[57.922950] Initializing watchdogs
[57.923058]   /dev/watchdog0
[57.938054] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.942761] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.944919] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.948258] [001/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[58.021171] Starting subtest: invalid-multi-wait-unsubmitted
[58.023665] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[58.112603] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[58.207801] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[58.211946] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[58.306618] [003/133] (960s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[58.394841] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[58.397218] Starting dynamic subtest: pipe-A-eDP-1
[58.419608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.427636] Starting dynamic subtest: pipe-B-eDP-1
[58.449132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.456322] Starting dynamic subtest: pipe-C-eDP-1
[58.477927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.485301] Starting dynamic subtest: pipe-D-eDP-1
[58.507194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.511204] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[60.913224] [004/133] (957s left) gem_mmap_gtt (basic-small-copy-odd)
[60.977473] Subtest basic-small-copy-odd: SKIP (0.000s)
[61.032704] [005/133] (957s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[61.132118] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[61.136559] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[61.199698] [006/133] (957s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[61.303247] Starting subtest: yf-tiled-32bpp-rotate-180
[61.307517] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[61.399106] [007/133] (957s left) syncobj_timeline (single-wait-available-signaled)
[61.463346] Starting subtest: single-wait-available-signaled
[61.465667] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[61.556878] [008/133] (957s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[61.680210] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[71.149528] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.491s)
[72.006898] [009/133] (946s left) gem_softpin (softpin)
[72.066740] Starting subtest: softpin
[104.322515] Subtest softpin: SUCCESS (32.256s)
[104.446935] [010/133] (914s left) gem_mmap_wc (read)
[104.513161] Subtest read: SKIP (0.000s)
[104.575807] [011/133] (914s left) gem_flink_basic (basic)
[104.622630] Starting subtest: basic
[104.624526] Subtest basic: SUCCESS (0.000s)
[104.714967] [012/133] (914s left) gem_exec_params (invalid-bsd1-flag-on-render)
[104.765617] Starting subtest: invalid-bsd1-flag-on-render
[104.767995] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[104.899809] [013/133] (914s left) gem_mmap_gtt (cpuset-big-copy)
[104.960251] Subtest cpuset-big-copy: SKIP (0.000s)
[105.017585] [014/133] (913s left) perf_pmu (busy-idle-check-all)
[105.057671] Starting subtest: busy-idle-check-all
[105.059895] Starting dynamic subtest: rcs0
[105.724244] Dynamic subtest rcs0: SUCCESS (0.666s)
[105.737030] Starting dynamic subtest: bcs0
[106.378957] Dynamic subtest bcs0: SUCCESS (0.655s)
[106.389837] Starting dynamic subtest: vcs0
[108.320472] Dynamic subtest vcs0: SUCCESS (1.938s)
[108.331805] Starting dynamic subtest: vcs1
[110.304033] Dynamic subtest vcs1: SUCCESS (1.983s)
[110.313605] Starting dynamic subtest: vecs0
[112.351896] Dynamic subtest vecs0: SUCCESS (2.047s)
[112.361787] Starting dynamic subtest: ccs0
[113.007040] Dynamic subtest ccs0: SUCCESS (0.656s)
[113.009624] Subtest busy-idle-check-all: SUCCESS (7.950s)
[113.123193] [015/133] (905s left) gem_render_copy_redux (flink)
[113.181783] Starting subtest: flink
[114.262186] Subtest flink: SUCCESS (1.081s)
[114.385873] [016/133] (904s left) kms_psr (fbc-psr-primary-blt)
[114.482175] Starting subtest: fbc-psr-primary-blt
[114.484226] Starting dynamic subtest: eDP-1
[114.487929] Dynamic subtest eDP-1: SKIP (0.000s)
[114.491755] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[114.549790] [017/133] (904s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[114.640016] Starting subtest: fbc-rgb565-draw-mmap-cpu
[118.887600] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.251s)
[120.028619] [018/133] (899s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[120.126674] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[120.130846] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[120.223068] [019/133] (898s left) gem_ctx_param (invalid-size-get)
[120.285277] Starting subtest: invalid-size-get
[120.287678] Subtest invalid-size-get: SUCCESS (0.002s)
[120.402660] [020/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[120.499656] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[127.390068] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.893s)
[127.547645] [021/133] (891s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[127.675275] Starting subtest: flip-vs-cursor-atomic
[135.148397] Subtest flip-vs-cursor-atomic: SUCCESS (7.472s)
[136.006486] [022/133] (883s left) kms_vblank (wait-busy-hang)
[136.096064] Starting subtest: wait-busy-hang
[136.098396] Starting dynamic subtest: pipe-A-eDP-1
[162.081098] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.982s)
[162.096411] Starting dynamic subtest: pipe-D-eDP-1
[177.069236] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.987s)
[177.071664] Subtest wait-busy-hang: SUCCESS (40.973s)
[177.862555] [023/133] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[177.962652] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[177.967214] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[178.066660] [024/133] (841s left) i915_query (test-query-geometry-subslices)
[178.124928] Starting subtest: test-query-geometry-subslices
[178.127294] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[178.230238] [025/133] (841s left) kms_chamelium_frames (hdmi-frame-dump)
[178.610775] Subtest hdmi-frame-dump: SKIP (0.000s)
[179.389999] [026/133] (840s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[179.515911] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[181.012387] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.495s)
[181.901521] [027/133] (837s left) kms_psr (psr-dpms)
[181.991562] Starting subtest: psr-dpms
[181.993834] Starting dynamic subtest: eDP-1
[184.919623] Dynamic subtest eDP-1: SUCCESS (2.928s)
[184.921969] Subtest psr-dpms: SUCCESS (2.928s)
[185.780908] [028/133] (833s left) perf (buffer-fill)
[185.899781] Starting subtest: buffer-fill
[185.902122] Starting dynamic subtest: 0-rcs0
[188.172916] Dynamic subtest 0-rcs0: SUCCESS (2.271s)
[188.183862] Starting dynamic subtest: 1-vecs0
[192.614896] Dynamic subtest 1-vecs0: SUCCESS (4.441s)
[192.617558] Subtest buffer-fill: SUCCESS (6.714s)
[192.663405] [029/133] (826s left) kms_feature_discovery (display)
[192.756153] Starting subtest: display
[192.758565] Subtest display: SUCCESS (0.000s)
[192.874534] [030/133] (826s left) syncobj_wait (invalid-single-wait-unsubmitted)
[192.923801] Starting subtest: invalid-single-wait-unsubmitted
[192.926106] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[193.019518] [031/133] (826s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[193.067821] Starting subtest: multi-wait-for-submit-submitted-signaled
[193.070198] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[193.152360] [032/133] (826s left) gem_exec_reloc (basic-concurrent0)
[193.213077] Subtest basic-concurrent0: SKIP (0.000s)
[193.285730] [033/133] (826s left) core_getversion (all-cards)
[193.322090] Starting subtest: all-cards
[193.329621] Subtest all-cards: SUCCESS (0.009s)
[193.374247] [034/133] (826s left) gem_request_retire (retire-vma-not-inactive)
[193.425252] Starting subtest: retire-vma-not-inactive
[193.485883] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[193.601667] [035/133] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[193.694672] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[193.698230] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.795644] [036/133] (826s left) gem_exec_schedule (timeslicing)
[193.864917] Starting subtest: timeslicing
[193.866901] Starting dynamic subtest: rcs0
[193.878631] Dynamic subtest rcs0: SUCCESS (0.022s)
[193.889723] Starting dynamic subtest: bcs0
[193.899903] Dynamic subtest bcs0: SUCCESS (0.021s)
[193.909078] Starting dynamic subtest: vcs0
[193.919742] Dynamic subtest vcs0: SUCCESS (0.020s)
[193.928248] Starting dynamic subtest: vcs1
[193.939096] Dynamic subtest vcs1: SUCCESS (0.019s)
[193.947263] Starting dynamic subtest: vecs0
[193.959144] Dynamic subtest vecs0: SUCCESS (0.020s)
[193.967499] Starting dynamic subtest: ccs0
[193.978027] Dynamic subtest ccs0: SUCCESS (0.019s)
[193.980089] Subtest timeslicing: SUCCESS (0.122s)
[195.402401] [037/133] (824s left) kms_psr (pr-sprite-render)
[195.489852] Starting subtest: pr-sprite-render
[195.494267] Subtest pr-sprite-render: SKIP (0.000s)
[195.563089] [038/133] (824s left) kms_frontbuffer_tracking (basic)
[195.662913] Starting subtest: basic
[198.992059] Subtest basic: SUCCESS (3.335s)
[199.116085] [039/133] (820s left) prime_vgem (sync)
[199.258174] Starting subtest: sync
[199.260036] Starting dynamic subtest: rcs0
[199.313072] Dynamic subtest rcs0: SUCCESS (0.055s)
[199.321612] Starting dynamic subtest: bcs0
[199.372978] Dynamic subtest bcs0: SUCCESS (0.059s)
[199.381562] Starting dynamic subtest: vcs0
[199.420922] Dynamic subtest vcs0: SUCCESS (0.048s)
[199.429270] Starting dynamic subtest: vcs1
[199.464955] Dynamic subtest vcs1: SUCCESS (0.043s)
[199.473381] Starting dynamic subtest: vecs0
[199.510677] Dynamic subtest vecs0: SUCCESS (0.045s)
[199.519127] Starting dynamic subtest: ccs0
[199.558137] Dynamic subtest ccs0: SUCCESS (0.047s)
[199.559879] Subtest sync: SUCCESS (0.300s)
[199.668151] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[199.670835] [040/133] (820s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[199.783890] Starting subtest: cursorA-vs-flipA-atomic
[210.903551] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.116s)
[211.718287] [041/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[211.805194] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[218.935393] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.132s)
[219.053079] [042/133] (801s left) prime_vgem (basic-gtt)
[219.136529] Starting subtest: basic-gtt
[219.140868] Subtest basic-gtt: SKIP (0.000s)
[219.251154] [043/133] (800s left) gem_ctx_persistence (hostile)
[219.319814] Starting subtest: hostile
[228.824474] Subtest hostile: SUCCESS (9.504s)
[228.941922] [044/133] (791s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[229.334642] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[230.160896] [045/133] (790s left) kms_frontbuffer_tracking (psr-1p-rte)
[230.251921] Starting subtest: psr-1p-rte
[235.717267] Subtest psr-1p-rte: SUCCESS (5.470s)
[235.854638] [046/133] (784s left) kms_psr (fbc-pr-primary-mmap-gtt)
[235.958656] Starting subtest: fbc-pr-primary-mmap-gtt
[235.963164] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[236.030513] [047/133] (784s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[236.142482] Starting subtest: cursorB-vs-flipB-atomic
[236.147061] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[236.287676] [048/133] (784s left) gem_eio (in-flight-internal-10ms)
[236.492241] Starting subtest: in-flight-internal-10ms
[238.369990] Subtest in-flight-internal-10ms: SUCCESS (1.876s)
[238.529052] [049/133] (781s left) kms_cursor_crc (cursor-offscreen-64x64)
[238.712995] Starting subtest: cursor-offscreen-64x64
[238.715407] Starting dynamic subtest: pipe-A-eDP-1
[240.664911] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[240.696525] Starting dynamic subtest: pipe-D-eDP-1
[243.335055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.643s)
[243.337035] Subtest cursor-offscreen-64x64: SUCCESS (4.622s)
[244.182810] [050/133] (776s left) gen7_exec_parse (oacontrol-tracking)
[244.239172] Subtest oacontrol-tracking: SKIP (0.000s)
[244.308815] [051/133] (776s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[244.395480] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[244.397624] Starting dynamic subtest: pipe-A-default-mode
[245.557456] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[245.562012] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.155s)
[245.686635] [052/133] (774s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[245.781098] Starting subtest: disable-crc-after-crtc
[245.783448] Starting dynamic subtest: pipe-A-eDP-1
[247.477563] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.695s)
[247.487854] Starting dynamic subtest: pipe-B-eDP-1
[249.763836] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.285s)
[249.774214] Starting dynamic subtest: pipe-C-eDP-1
[252.022058] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[252.032493] Starting dynamic subtest: pipe-D-eDP-1
[254.277713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[254.280035] Subtest disable-crc-after-crtc: SUCCESS (8.498s)
[255.099496] [053/133] (765s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[255.193883] Starting subtest: primary-yf-tiled-reflect-x-0
[255.254123] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[255.359082] [054/133] (765s left) gem_ctx_persistence (engines-hang)
[255.416373] Starting subtest: engines-hang
[255.418755] Starting dynamic subtest: rcs0
[255.545779] Dynamic subtest rcs0: SUCCESS (0.129s)
[255.557954] Starting dynamic subtest: bcs0
[255.642818] Dynamic subtest bcs0: SUCCESS (0.095s)
[255.655676] Starting dynamic subtest: vcs0
[255.754177] Dynamic subtest vcs0: SUCCESS (0.109s)
[255.765613] Starting dynamic subtest: vcs1
[255.849729] Dynamic subtest vcs1: SUCCESS (0.094s)
[255.862049] Starting dynamic subtest: vecs0
[255.948230] Dynamic subtest vecs0: SUCCESS (0.096s)
[255.958835] Starting dynamic subtest: ccs0
[256.036994] Dynamic subtest ccs0: SUCCESS (0.087s)
[256.039324] Subtest engines-hang: SUCCESS (0.622s)
[256.129343] [055/133] (764s left) gem_eio (in-flight-1us)
[256.358553] Starting subtest: in-flight-1us
[265.047698] Subtest in-flight-1us: SUCCESS (8.688s)
[265.195775] [056/133] (755s left) gem_mmap_wc (pf-nonblock)
[265.252243] Subtest pf-nonblock: SKIP (0.000s)
[265.312934] [057/133] (755s left) kms_flip (plain-flip-fb-recreate-interruptible)
[265.407563] Starting subtest: plain-flip-fb-recreate-interruptible
[265.412499] Starting dynamic subtest: A-eDP1
[274.294057] Dynamic subtest A-eDP1: SUCCESS (8.884s)
[274.304466] Starting dynamic subtest: B-eDP1
[283.133907] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[283.144989] Starting dynamic subtest: C-eDP1
[291.951093] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[291.960541] Starting dynamic subtest: D-eDP1
[300.778893] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[300.783042] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.373s)
[301.968632] [058/133] (718s left) gem_exec_reloc (basic-wc-gtt-active)
[302.025510] Subtest basic-wc-gtt-active: SKIP (0.000s)
[302.096560] [059/133] (718s left) kms_async_flips (async-flip-hang)
[302.189762] Starting subtest: async-flip-hang
[302.562422] Starting dynamic subtest: pipe-A-eDP-1
[317.821050] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.253s)
[318.202654] Starting dynamic subtest: pipe-B-eDP-1
[333.820398] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.622s)
[334.194238] Starting dynamic subtest: pipe-C-eDP-1
[349.816082] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.629s)
[350.204095] Starting dynamic subtest: pipe-D-eDP-1
[365.821611] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.624s)
[365.823885] Subtest async-flip-hang: SUCCESS (63.629s)
[367.035264] [060/133] (653s left) gem_exec_flush (basic-wb-set-default)
[367.096905] Starting subtest: basic-wb-set-default
[372.551701] Subtest basic-wb-set-default: SUCCESS (5.455s)
[372.742935] [061/133] (648s left) kms_cursor_edge_walk (128x128-top-edge)
[372.844063] Starting subtest: 128x128-top-edge
[372.846334] Starting dynamic subtest: pipe-A-eDP-1
[376.301096] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[376.311941] Starting dynamic subtest: pipe-D-eDP-1
[379.427149] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[379.429309] Subtest 128x128-top-edge: SUCCESS (6.586s)
[380.230811] [062/133] (640s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[380.339703] Starting subtest: x-tiled-8bpp-rotate-180
[381.608965] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.269s)
[381.746541] [063/133] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[381.841989] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[381.845520] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[381.944623] [064/133] (639s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[382.036374] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[382.038214] Starting dynamic subtest: pipe-A-eDP-1
[382.056145] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[382.065860] Starting dynamic subtest: pipe-B-eDP-1
[382.083171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[382.092430] Starting dynamic subtest: pipe-C-eDP-1
[382.109361] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[382.118435] Starting dynamic subtest: pipe-D-eDP-1
[382.136267] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[382.139659] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[384.312795] [065/133] (636s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[384.407307] Starting subtest: 4-tiled-32bpp-rotate-180
[385.843208] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.436s)
[386.011470] [066/133] (635s left) gem_exec_fence (syncobj-channel)
[386.441828] Starting subtest: syncobj-channel
[387.457394] Subtest syncobj-channel: SUCCESS (1.015s)
[388.396574] [067/133] (632s left) kms_mmap_write_crc (main)
[388.487837] Starting subtest: main
[388.490117] Starting dynamic subtest: pipe-A-eDP-1
[392.036966] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.545s)
[392.039665] Subtest main: SUCCESS (3.546s)
[392.836277] [068/133] (628s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[392.937849] Starting subtest: y-tiled-32bpp-rotate-180
[392.942242] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[393.041945] [069/133] (628s left) kms_pm_rpm (fences-dpms)
[394.579483] Starting subtest: fences-dpms
[394.584895] Subtest fences-dpms: SKIP (0.000s)
[395.286677] [070/133] (625s left) gem_ctx_param (set-priority-range)
[395.341932] Starting subtest: set-priority-range
[395.359187] Subtest set-priority-range: SUCCESS (0.018s)
[395.495277] [071/133] (625s left) api_intel_allocator (alloc-simple)
[395.551108] Starting subtest: alloc-simple
[395.553302] Subtest alloc-simple: SUCCESS (0.003s)
[395.678025] [072/133] (625s left) gem_exec_schedule (preempt-other-chain)
[395.748067] Starting subtest: preempt-other-chain
[395.750507] Starting dynamic subtest: rcs0
[395.826468] Dynamic subtest rcs0: SUCCESS (0.084s)
[395.839702] Starting dynamic subtest: bcs0
[395.913705] Dynamic subtest bcs0: SUCCESS (0.086s)
[395.927070] Starting dynamic subtest: vcs0
[395.998644] Dynamic subtest vcs0: SUCCESS (0.084s)
[396.008857] Starting dynamic subtest: vcs1
[396.080753] Dynamic subtest vcs1: SUCCESS (0.081s)
[396.090984] Starting dynamic subtest: vecs0
[396.161040] Dynamic subtest vecs0: SUCCESS (0.079s)
[396.174938] Starting dynamic subtest: ccs0
[396.242307] Dynamic subtest ccs0: SUCCESS (0.081s)
[396.244507] Subtest preempt-other-chain: SUCCESS (0.501s)
[397.440066] [073/133] (623s left) kms_addfb_basic (too-wide)
[397.545021] Starting subtest: too-wide
[397.547157] Subtest too-wide: SUCCESS (0.000s)
[397.638248] [074/133] (623s left) gem_userptr_blits (set-cache-level)
[397.709307] Starting subtest: set-cache-level
[397.714549] Subtest set-cache-level: SKIP (0.000s)
[397.831456] [075/133] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[397.922948] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[397.927270] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[398.040591] [076/133] (623s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[398.124282] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[398.126478] Starting dynamic subtest: pipe-A-eDP-1
[398.135225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.146428] Starting dynamic subtest: pipe-B-eDP-1
[398.155165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.165499] Starting dynamic subtest: pipe-C-eDP-1
[398.174738] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[398.184454] Starting dynamic subtest: pipe-D-eDP-1
[398.193194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[398.197589] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[400.359460] [077/133] (621s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[400.448291] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[400.460979] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[400.539673] [078/133] (621s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[400.629057] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[400.655116] Starting dynamic subtest: pipe-A-plane-0
[401.332227] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[401.341903] Starting dynamic subtest: pipe-A-plane-3
[401.765697] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[402.841864] Starting dynamic subtest: pipe-B-plane-0
[403.510417] Dynamic subtest pipe-B-plane-0: SUCCESS (0.677s)
[403.520599] Starting dynamic subtest: pipe-B-plane-3
[403.942850] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[404.267054] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.636s)
[405.138474] [079/133] (616s left) gem_exec_params (rsvd2-dirt)
[405.194626] Starting subtest: rsvd2-dirt
[405.198983] Subtest rsvd2-dirt: SKIP (0.000s)
[405.313324] [080/133] (616s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[405.406594] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[405.408881] Starting dynamic subtest: pipe-A-eDP-1
[405.931299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[405.943658] Starting dynamic subtest: pipe-B-eDP-1
[407.413228] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s)
[407.423900] Starting dynamic subtest: pipe-C-eDP-1
[408.857581] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.441s)
[408.868977] Starting dynamic subtest: pipe-D-eDP-1
[410.338642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.482s)
[410.340975] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.905s)
[411.476905] [081/133] (610s left) kms_big_fb (linear-16bpp-rotate-90)
[411.579352] Starting subtest: linear-16bpp-rotate-90
[411.598967] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[411.729229] [082/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[411.819834] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[419.207056] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.390s)
[419.357043] [083/133] (602s left) kms_chamelium_audio (dp-audio)
[419.754565] Subtest dp-audio: SKIP (0.000s)
[420.517473] [084/133] (601s left) gem_bad_reloc (negative-reloc-lut)
[420.574717] Subtest negative-reloc-lut: SKIP (0.000s)
[420.667944] [085/133] (601s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[420.761305] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[420.765850] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[420.842812] [086/133] (601s left) i915_hangman (detector)
[420.900049] Starting subtest: detector
[420.901947] Starting dynamic subtest: rcs0
[432.319088] Dynamic subtest rcs0: SUCCESS (11.419s)
[432.332979] Starting dynamic subtest: bcs0
[444.286569] Dynamic subtest bcs0: SUCCESS (11.964s)
[444.299622] Starting dynamic subtest: vcs0
[456.254096] Dynamic subtest vcs0: SUCCESS (11.965s)
[456.269293] Starting dynamic subtest: vcs1
[468.223397] Dynamic subtest vcs1: SUCCESS (11.965s)
[468.235548] Starting dynamic subtest: vecs0
[480.317926] Dynamic subtest vecs0: SUCCESS (12.093s)
[480.331043] Starting dynamic subtest: ccs0
[492.286039] Dynamic subtest ccs0: SUCCESS (11.965s)
[492.288973] Subtest detector: SUCCESS (71.386s)
[492.373325] [087/133] (529s left) sysfs_heartbeat_interval (mixed)
[492.430681] Starting subtest: mixed
[492.432962] Starting dynamic subtest: vecs0
[497.688227] Dynamic subtest vecs0: SUCCESS (5.257s)
[497.700070] Starting dynamic subtest: ccs0
[502.877898] Dynamic subtest ccs0: SUCCESS (5.187s)
[502.890825] Starting dynamic subtest: vcs0
[508.083286] Dynamic subtest vcs0: SUCCESS (5.203s)
[508.097085] Starting dynamic subtest: bcs0
[513.297962] Dynamic subtest bcs0: SUCCESS (5.212s)
[513.311355] Starting dynamic subtest: rcs0
[518.502328] Dynamic subtest rcs0: SUCCESS (5.201s)
[518.513456] Starting dynamic subtest: vcs1
[523.746538] Dynamic subtest vcs1: SUCCESS (5.242s)
[523.749059] Subtest mixed: SUCCESS (31.316s)
[523.826955] [088/133] (498s left) kms_universal_plane (universal-plane-pageflip-windowed)
[523.918797] Starting subtest: universal-plane-pageflip-windowed
[523.920945] Starting dynamic subtest: pipe-A-eDP-1
[524.512230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[524.522933] Starting dynamic subtest: pipe-B-eDP-1
[525.760704] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[525.772253] Starting dynamic subtest: pipe-C-eDP-1
[526.973087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[526.984144] Starting dynamic subtest: pipe-D-eDP-1
[528.213052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[528.215433] Subtest universal-plane-pageflip-windowed: SUCCESS (4.294s)
[529.074487] [089/133] (493s left) kms_dp_link_training (uhbr-sst)
[529.169713] Starting subtest: uhbr-sst
[529.178382] Subtest uhbr-sst: SKIP (0.000s)
[529.242331] [090/133] (492s left) gem_exec_balancer (bonded-pair)
[529.309305] Starting subtest: bonded-pair
[529.313578] Subtest bonded-pair: SKIP (0.000s)
[529.600344] [091/133] (492s left) gem_exec_fence (invalid-fence-array)
[530.033544] Starting subtest: invalid-fence-array
[530.035950] Subtest invalid-fence-array: SUCCESS (0.002s)
[531.368373] [092/133] (490s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[531.466632] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[531.471141] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[531.566618] [093/133] (490s left) kms_psr (psr-cursor-plane-onoff)
[531.657397] Starting subtest: psr-cursor-plane-onoff
[531.659711] Starting dynamic subtest: eDP-1
[533.350409] Dynamic subtest eDP-1: SUCCESS (1.693s)
[533.352665] Subtest psr-cursor-plane-onoff: SUCCESS (1.694s)
[534.219152] [094/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[534.319586] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[534.324055] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[534.420585] [095/133] (488s left) kms_busy (basic)
[534.519112] Starting subtest: basic
[534.521032] Starting dynamic subtest: flip
[535.123408] Dynamic subtest flip: SUCCESS (0.603s)
[535.134378] Starting dynamic subtest: modeset
[538.553206] Dynamic subtest modeset: SUCCESS (3.428s)
[538.555506] Subtest basic: SUCCESS (4.034s)
[539.354934] [096/133] (483s left) gem_exec_async (forked-writes)
[539.412613] Starting subtest: forked-writes
[539.414742] Starting dynamic subtest: rcs0
[539.441784] Dynamic subtest rcs0: SUCCESS (0.029s)
[539.456869] Starting dynamic subtest: bcs0
[539.466039] Dynamic subtest bcs0: SUCCESS (0.023s)
[539.477697] Starting dynamic subtest: vcs0
[539.487447] Dynamic subtest vcs0: SUCCESS (0.021s)
[539.498992] Starting dynamic subtest: vcs1
[539.510447] Dynamic subtest vcs1: SUCCESS (0.022s)
[539.521654] Starting dynamic subtest: vecs0
[539.532847] Dynamic subtest vecs0: SUCCESS (0.022s)
[539.547492] Starting dynamic subtest: ccs0
[539.555159] Dynamic subtest ccs0: SUCCESS (0.021s)
[539.557325] Subtest forked-writes: SUCCESS (0.143s)
[539.809995] [097/133] (482s left) prime_vgem (coherency-gtt)
[539.877320] Starting subtest: coherency-gtt
[539.881599] Subtest coherency-gtt: SKIP (0.000s)
[539.987167] [098/133] (482s left) kms_properties (colorop-properties-legacy)
[540.075899] Starting subtest: colorop-properties-legacy
[540.078199] Starting dynamic subtest: pipe-A-eDP-1
[540.446427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s)
[540.457260] Starting dynamic subtest: pipe-B-eDP-1
[541.530251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s)
[541.540854] Starting dynamic subtest: pipe-C-eDP-1
[542.567568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[542.578584] Starting dynamic subtest: pipe-D-eDP-1
[543.595180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s)
[543.597441] Subtest colorop-properties-legacy: SUCCESS (3.518s)
[544.395509] [099/133] (478s left) gem_mmap_wc (set-cache-level)
[544.459408] Subtest set-cache-level: SKIP (0.000s)
[544.530971] [100/133] (478s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[544.634113] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[551.634438] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.002s)
[551.762496] [101/133] (470s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[551.852317] Starting subtest: fbc-psr2-primary-mmap-cpu
[551.854734] Starting dynamic subtest: eDP-1
[551.859316] Dynamic subtest eDP-1: SKIP (0.000s)
[551.863998] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[551.925578] [102/133] (470s left) syncobj_timeline (32bits-limit)
[551.981835] Starting subtest: 32bits-limit
[551.984332] Subtest 32bits-limit: SUCCESS (0.001s)
[552.102235] [103/133] (470s left) perf_pmu (busy-accuracy-98)
[552.144996] Starting subtest: busy-accuracy-98
[552.147229] Starting dynamic subtest: rcs0
[555.184610] Dynamic subtest rcs0: SUCCESS (3.036s)
[555.197490] Starting dynamic subtest: bcs0
[558.238221] Dynamic subtest bcs0: SUCCESS (3.052s)
[558.248037] Starting dynamic subtest: vcs0
[561.280554] Dynamic subtest vcs0: SUCCESS (3.038s)
[561.293704] Starting dynamic subtest: vcs1
[564.318352] Dynamic subtest vcs1: SUCCESS (3.036s)
[564.330562] Starting dynamic subtest: vecs0
[567.356438] Dynamic subtest vecs0: SUCCESS (3.037s)
[567.366809] Starting dynamic subtest: ccs0
[570.413795] Dynamic subtest ccs0: SUCCESS (3.053s)
[570.416206] Subtest busy-accuracy-98: SUCCESS (18.265s)
[570.528530] [104/133] (452s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[570.631077] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[570.633362] Starting dynamic subtest: pipe-A
[570.653075] Dynamic subtest pipe-A: SKIP (0.019s)
[570.663704] Starting dynamic subtest: pipe-B
[570.689147] Dynamic subtest pipe-B: SKIP (0.035s)
[570.699896] Starting dynamic subtest: pipe-C
[570.721878] Dynamic subtest pipe-C: SKIP (0.033s)
[570.731882] Starting dynamic subtest: pipe-D
[570.755183] Dynamic subtest pipe-D: SKIP (0.032s)
[570.759473] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.122s)
[570.859020] [105/133] (451s left) gem_exec_whisper (basic-normal-all)
[570.918724] Starting subtest: basic-normal-all
[573.227893] Subtest basic-normal-all: SUCCESS (2.307s)
[573.420854] [106/133] (449s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[573.545030] Starting subtest: verify-pxp-execution-after-suspend-resume
[580.683448] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.140s)
[591.832568] [107/133] (442s left) gem_exec_reloc (basic-range-active)
[591.896724] Subtest basic-range-active: SKIP (0.000s)
[591.975916] [108/133] (442s left) kms_content_protection (dp-mst-type-1)
[592.120703] Starting subtest: dp-mst-type-1
[592.124823] Subtest dp-mst-type-1: SKIP (0.000s)
[592.225659] [109/133] (441s left) kms_invalid_mode (bad-htotal)
[592.314327] Starting subtest: bad-htotal
[592.316624] Starting dynamic subtest: pipe-A-eDP-1
[592.607992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[592.619833] Starting dynamic subtest: pipe-B-eDP-1
[592.621937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[592.632830] Starting dynamic subtest: pipe-C-eDP-1
[592.635092] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[592.645401] Starting dynamic subtest: pipe-D-eDP-1
[592.647681] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[592.650055] Subtest bad-htotal: SUCCESS (0.300s)
[593.452885] [110/133] (440s left) gem_userptr_blits (unsync-unmap-after-close)
[593.520178] Subtest unsync-unmap-after-close: SKIP (0.000s)
[593.642865] [111/133] (440s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[593.736718] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[593.741089] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[593.823507] [112/133] (440s left) gem_exec_whisper (basic-queues-priority)
[593.877311] Starting subtest: basic-queues-priority
[617.469996] Subtest basic-queues-priority: SUCCESS (23.588s)
[617.664936] [113/133] (416s left) kms_flip (2x-flip-vs-suspend)
[617.764098] Starting subtest: 2x-flip-vs-suspend
[617.768439] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[617.893959] [114/133] (416s left) gem_ctx_engines (execute-one)
[617.957206] Starting subtest: execute-one
[620.281640] Subtest execute-one: SUCCESS (2.328s)
[620.488409] [115/133] (413s left) kms_color_pipeline (plane-ctm3x4)
[620.590942] Starting subtest: plane-ctm3x4
[620.770451] Starting dynamic subtest: pipe-A-plane-0
[620.916047] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[620.927593] Starting dynamic subtest: pipe-A-plane-1
[621.070101] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[621.081502] Starting dynamic subtest: pipe-A-plane-2
[621.204032] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[622.404714] Starting dynamic subtest: pipe-B-plane-0
[622.562315] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[622.573762] Starting dynamic subtest: pipe-B-plane-1
[622.695272] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[622.707733] Starting dynamic subtest: pipe-B-plane-2
[622.841926] Dynamic subtest pipe-B-plane-2: SUCCESS (0.143s)
[624.122679] Starting dynamic subtest: pipe-C-plane-0
[624.235029] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[624.247612] Starting dynamic subtest: pipe-C-plane-1
[624.368072] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[624.379754] Starting dynamic subtest: pipe-C-plane-2
[624.501410] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[625.748037] Starting dynamic subtest: pipe-D-plane-0
[625.895834] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[625.907256] Starting dynamic subtest: pipe-D-plane-1
[626.027413] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[626.038270] Starting dynamic subtest: pipe-D-plane-2
[626.149512] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[626.446346] Subtest plane-ctm3x4: SUCCESS (5.856s)
[627.306636] [116/133] (407s left) kms_plane (plane-position-hole-dpms)
[627.401501] Starting subtest: plane-position-hole-dpms
[627.934311] Starting dynamic subtest: pipe-A-plane-1
[630.314153] Dynamic subtest pipe-A-plane-1: SUCCESS (2.377s)
[630.326221] Starting dynamic subtest: pipe-A-plane-2
[632.699544] Dynamic subtest pipe-A-plane-2: SUCCESS (2.386s)
[632.710629] Starting dynamic subtest: pipe-A-plane-3
[635.130957] Dynamic subtest pipe-A-plane-3: SUCCESS (2.432s)
[635.143460] Starting dynamic subtest: pipe-A-plane-4
[637.501106] Dynamic subtest pipe-A-plane-4: SUCCESS (2.367s)
[637.512543] Starting dynamic subtest: pipe-A-plane-5
[637.529638] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[638.701725] Starting dynamic subtest: pipe-B-plane-1
[641.114738] Dynamic subtest pipe-B-plane-1: SUCCESS (2.421s)
[641.126457] Starting dynamic subtest: pipe-B-plane-2
[643.494072] Dynamic subtest pipe-B-plane-2: SUCCESS (2.381s)
[643.506601] Starting dynamic subtest: pipe-B-plane-3
[645.939576] Dynamic subtest pipe-B-plane-3: SUCCESS (2.445s)
[645.950938] Starting dynamic subtest: pipe-B-plane-4
[648.404814] Dynamic subtest pipe-B-plane-4: SUCCESS (2.461s)
[648.416202] Starting dynamic subtest: pipe-B-plane-5
[648.429321] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[648.431653] Subtest plane-position-hole-dpms: SUCCESS (21.027s)
[649.294297] [117/133] (385s left) kms_plane_cursor (primary)
[649.390913] Starting subtest: primary
[649.395400] Starting dynamic subtest: pipe-A-eDP-1-size-64
[651.951471] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.557s)
[651.979110] Starting dynamic subtest: pipe-A-eDP-1-size-128
[654.519075] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[654.544795] Starting dynamic subtest: pipe-A-eDP-1-size-256
[657.109023] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[657.428662] Starting dynamic subtest: pipe-B-eDP-1-size-64
[660.696585] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.281s)
[660.723833] Starting dynamic subtest: pipe-B-eDP-1-size-128
[663.298814] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[663.326478] Starting dynamic subtest: pipe-B-eDP-1-size-256
[665.900051] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[666.220881] Starting dynamic subtest: pipe-C-eDP-1-size-64
[669.194442] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.987s)
[669.223598] Starting dynamic subtest: pipe-C-eDP-1-size-128
[671.461674] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.248s)
[671.489061] Starting dynamic subtest: pipe-C-eDP-1-size-256
[673.783639] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.303s)
[674.103708] Starting dynamic subtest: pipe-D-eDP-1-size-64
[677.061092] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.971s)
[677.090468] Starting dynamic subtest: pipe-D-eDP-1-size-128
[679.340056] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.259s)
[679.367082] Starting dynamic subtest: pipe-D-eDP-1-size-256
[681.583609] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s)
[681.890840] Subtest primary: SUCCESS (32.498s)
[682.730611] [118/133] (351s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[682.834551] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[682.839069] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[682.956229] [119/133] (351s left) gen9_exec_parse (unaligned-access)
[683.008592] Subtest unaligned-access: SKIP (0.000s)
[683.085390] [120/133] (351s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[683.147939] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[683.152671] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[683.335653] [121/133] (351s left) kms_cursor_crc (cursor-random-64x64)
[683.512976] Starting subtest: cursor-random-64x64
[683.515175] Starting dynamic subtest: pipe-A-eDP-1
[686.880328] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.363s)
[686.915702] Starting dynamic subtest: pipe-D-eDP-1
[690.852596] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.950s)
[690.855112] Subtest cursor-random-64x64: SUCCESS (7.342s)
[691.698824] [122/133] (342s left) dumb_buffer (create-valid-dumb)
[691.754888] Starting subtest: create-valid-dumb
[691.757186] Subtest create-valid-dumb: SUCCESS (0.000s)
[691.874456] [123/133] (342s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[691.926160] Starting subtest: etime-multi-wait-all-submitted-signaled
[692.027089] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[692.103416] [124/133] (342s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[692.204585] Starting subtest: 4-tiled-16bpp-rotate-180
[693.561950] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.357s)
[693.661919] [125/133] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[693.750983] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[693.754594] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[693.845782] [126/133] (340s left) i915_pm_rc6_residency (rc6-idle)
[693.888125] Starting subtest: rc6-idle
[693.904529] Starting dynamic subtest: gt0-rcs0
[718.116847] Dynamic subtest gt0-rcs0: SUCCESS (24.211s)
[718.127476] Starting dynamic subtest: gt0-bcs0
[742.412603] Dynamic subtest gt0-bcs0: SUCCESS (24.293s)
[742.429057] Starting dynamic subtest: gt0-ccs0
[766.699195] Dynamic subtest gt0-ccs0: SUCCESS (24.284s)
[766.709890] Starting dynamic subtest: gt1-vcs0
[772.871335] Dynamic subtest gt1-vcs0: SUCCESS (6.168s)
[772.884505] Starting dynamic subtest: gt1-vecs0
[779.042642] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[779.045513] Subtest rc6-idle: SUCCESS (85.153s)
[779.124706] [127/133] (255s left) kms_pm_rpm (universal-planes-dpms)
[780.655830] Starting subtest: universal-planes-dpms
[780.658562] Starting dynamic subtest: plane-35
[789.084594] Dynamic subtest plane-35: SUCCESS (8.432s)
[789.097315] Starting dynamic subtest: plane-65
[797.681333] Dynamic subtest plane-65: SUCCESS (8.593s)
[797.695770] Starting dynamic subtest: plane-95
[805.972914] Dynamic subtest plane-95: SUCCESS (8.290s)
[805.986250] Starting dynamic subtest: plane-125
[814.598264] Dynamic subtest plane-125: SUCCESS (8.623s)
[814.612075] Starting dynamic subtest: plane-135
[822.891845] Dynamic subtest plane-135: SUCCESS (8.290s)
[822.905531] Starting dynamic subtest: plane-145
[831.215356] Dynamic subtest plane-145: SUCCESS (8.320s)
[831.218352] Subtest universal-planes-dpms: SUCCESS (50.563s)
[831.597544] [128/133] (203s left) gem_mmap_offset (bad-object)
[831.653882] Starting subtest: bad-object
[831.656394] Subtest bad-object: SUCCESS (0.001s)
[831.756402] [129/133] (203s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[831.869991] Starting subtest: fbc-modesetfrombusy
[835.632744] Subtest fbc-modesetfrombusy: SUCCESS (3.766s)
[836.807886] [130/133] (198s left) kms_properties (invalid-properties-legacy)
[836.908942] Starting subtest: invalid-properties-legacy
[837.017392] Subtest invalid-properties-legacy: SUCCESS (0.109s)
[837.096208] [131/133] (197s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[837.150304] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[837.152521] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[837.271166] [132/133] (197s left) gem_softpin (evict-single-offset)
[837.328333] Starting subtest: evict-single-offset
[865.312319] Subtest evict-single-offset: SUCCESS (27.980s)
[865.414617] [133/133] (169s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[865.568570] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[865.572936] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[865.663647] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_flink_basic
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_render_copy_redux
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: core_getversion
results: parsing output: 33/ for test: gem_request_retire
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gen7_exec_parse
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_mmap_write_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_chamelium_audio
results: parsing output: 83/ for test: gem_bad_reloc
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: sysfs_heartbeat_interval
results: parsing output: 87/ for test: kms_universal_plane
results: parsing output: 88/ for test: kms_dp_link_training
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_busy
results: parsing output: 95/ for test: gem_exec_async
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_ctx_engines
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_plane_cursor
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.