[58.208361] Initializing watchdogs
[58.208410]   /dev/watchdog0
[58.223495] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.228388] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.230645] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.233889] [001/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[58.313257] Starting subtest: invalid-multi-wait-unsubmitted
[58.315486] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[58.432191] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[58.531878] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[58.536107] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[58.622987] [003/133] (960s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[58.724177] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[58.727980] Starting dynamic subtest: pipe-A-eDP-1
[58.750063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.759374] Starting dynamic subtest: pipe-B-eDP-1
[58.780338] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.787340] Starting dynamic subtest: pipe-C-eDP-1
[58.809071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.815832] Starting dynamic subtest: pipe-D-eDP-1
[58.836805] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.841044] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[61.036905] [004/133] (957s left) gem_mmap_gtt (basic-small-copy-odd)
[61.103987] Subtest basic-small-copy-odd: SKIP (0.000s)
[61.165325] [005/133] (957s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[61.254319] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[61.258256] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[61.323396] [006/133] (957s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[61.431401] Starting subtest: yf-tiled-32bpp-rotate-180
[61.435478] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[61.511400] [007/133] (957s left) syncobj_timeline (single-wait-available-signaled)
[61.572766] Starting subtest: single-wait-available-signaled
[61.575291] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[61.666905] [008/133] (957s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[61.783185] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[71.324073] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.543s)
[72.164299] [009/133] (946s left) gem_softpin (softpin)
[72.318059] Starting subtest: softpin
[104.569101] Subtest softpin: SUCCESS (32.219s)
[104.691204] [010/133] (914s left) gem_mmap_wc (read)
[104.740830] Subtest read: SKIP (0.000s)
[104.800081] [011/133] (914s left) gem_flink_basic (basic)
[104.848769] Starting subtest: basic
[104.851067] Subtest basic: SUCCESS (0.000s)
[104.937012] [012/133] (914s left) gem_exec_params (invalid-bsd1-flag-on-render)
[104.990084] Starting subtest: invalid-bsd1-flag-on-render
[104.992337] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[105.099231] [013/133] (914s left) gem_mmap_gtt (cpuset-big-copy)
[105.155476] Subtest cpuset-big-copy: SKIP (0.000s)
[105.210768] [014/133] (914s left) perf_pmu (busy-idle-check-all)
[105.249035] Starting subtest: busy-idle-check-all
[105.251271] Starting dynamic subtest: rcs0
[105.920676] Dynamic subtest rcs0: SUCCESS (0.671s)
[105.932072] Starting dynamic subtest: bcs0
[106.577142] Dynamic subtest bcs0: SUCCESS (0.655s)
[106.589820] Starting dynamic subtest: vcs0
[108.324775] Dynamic subtest vcs0: SUCCESS (1.744s)
[108.335082] Starting dynamic subtest: vcs1
[110.308890] Dynamic subtest vcs1: SUCCESS (1.982s)
[110.318873] Starting dynamic subtest: vecs0
[112.356831] Dynamic subtest vecs0: SUCCESS (2.046s)
[112.367789] Starting dynamic subtest: ccs0
[113.012216] Dynamic subtest ccs0: SUCCESS (0.656s)
[113.014759] Subtest busy-idle-check-all: SUCCESS (7.760s)
[113.107637] [015/133] (906s left) gem_render_copy_redux (flink)
[113.174189] Starting subtest: flink
[114.248323] Subtest flink: SUCCESS (1.074s)
[114.393407] [016/133] (904s left) kms_psr (fbc-psr-primary-blt)
[114.495061] Starting subtest: fbc-psr-primary-blt
[114.496885] Starting dynamic subtest: eDP-1
[114.500280] Dynamic subtest eDP-1: SKIP (0.000s)
[114.503617] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[114.565349] [017/133] (904s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[114.657472] Starting subtest: fbc-rgb565-draw-mmap-cpu
[118.981632] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.325s)
[120.146365] [018/133] (899s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[120.245391] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[120.249567] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[120.346090] [019/133] (899s left) gem_ctx_param (invalid-size-get)
[120.394631] Starting subtest: invalid-size-get
[120.396975] Subtest invalid-size-get: SUCCESS (0.001s)
[120.490731] [020/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[120.589713] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[127.476115] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.888s)
[127.619754] [021/133] (891s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[127.744839] Starting subtest: flip-vs-cursor-atomic
[135.205838] Subtest flip-vs-cursor-atomic: SUCCESS (7.458s)
[136.004623] [022/133] (883s left) kms_vblank (wait-busy-hang)
[136.096040] Starting subtest: wait-busy-hang
[136.098072] Starting dynamic subtest: pipe-A-eDP-1
[162.093894] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.996s)
[162.108780] Starting dynamic subtest: pipe-D-eDP-1
[177.061100] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.964s)
[177.063452] Subtest wait-busy-hang: SUCCESS (40.965s)
[177.872632] [023/133] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[177.971225] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[177.975207] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[178.075768] [024/133] (841s left) i915_query (test-query-geometry-subslices)
[178.126616] Starting subtest: test-query-geometry-subslices
[178.128903] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[178.218361] [025/133] (841s left) kms_chamelium_frames (hdmi-frame-dump)
[178.591246] Subtest hdmi-frame-dump: SKIP (0.000s)
[179.381215] [026/133] (840s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[179.499840] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[180.894188] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.393s)
[181.686110] [027/133] (838s left) kms_psr (psr-dpms)
[181.771998] Starting subtest: psr-dpms
[181.774292] Starting dynamic subtest: eDP-1
[184.701518] Dynamic subtest eDP-1: SUCCESS (2.930s)
[184.703838] Subtest psr-dpms: SUCCESS (2.931s)
[185.569431] [028/133] (834s left) perf (buffer-fill)
[185.707238] Starting subtest: buffer-fill
[185.709819] Starting dynamic subtest: 0-rcs0
[187.978754] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[187.988873] Starting dynamic subtest: 1-vecs0
[192.427833] Dynamic subtest 1-vecs0: SUCCESS (4.448s)
[192.430816] Subtest buffer-fill: SUCCESS (6.720s)
[192.474897] [029/133] (827s left) kms_feature_discovery (display)
[192.573186] Starting subtest: display
[192.575525] Subtest display: SUCCESS (0.000s)
[192.644730] [030/133] (827s left) syncobj_wait (invalid-single-wait-unsubmitted)
[192.701088] Starting subtest: invalid-single-wait-unsubmitted
[192.703597] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[192.796871] [031/133] (827s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[192.844025] Starting subtest: multi-wait-for-submit-submitted-signaled
[192.846406] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[192.931169] [032/133] (827s left) gem_exec_reloc (basic-concurrent0)
[192.995918] Subtest basic-concurrent0: SKIP (0.000s)
[193.058939] [033/133] (826s left) core_getversion (all-cards)
[193.091396] Starting subtest: all-cards
[193.098627] Subtest all-cards: SUCCESS (0.009s)
[193.143274] [034/133] (826s left) gem_request_retire (retire-vma-not-inactive)
[193.193717] Starting subtest: retire-vma-not-inactive
[193.253384] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[193.381097] [035/133] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[193.468220] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[193.471836] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.556546] [036/133] (826s left) gem_exec_schedule (timeslicing)
[193.615760] Starting subtest: timeslicing
[193.617723] Starting dynamic subtest: rcs0
[193.630415] Dynamic subtest rcs0: SUCCESS (0.022s)
[193.641287] Starting dynamic subtest: bcs0
[193.651146] Dynamic subtest bcs0: SUCCESS (0.020s)
[193.660380] Starting dynamic subtest: vcs0
[193.672045] Dynamic subtest vcs0: SUCCESS (0.020s)
[193.680531] Starting dynamic subtest: vcs1
[193.694214] Dynamic subtest vcs1: SUCCESS (0.021s)
[193.704787] Starting dynamic subtest: vecs0
[193.714421] Dynamic subtest vecs0: SUCCESS (0.021s)
[193.725761] Starting dynamic subtest: ccs0
[193.735660] Dynamic subtest ccs0: SUCCESS (0.020s)
[193.737632] Subtest timeslicing: SUCCESS (0.127s)
[195.425861] [037/133] (824s left) kms_psr (pr-sprite-render)
[195.518884] Starting subtest: pr-sprite-render
[195.523137] Subtest pr-sprite-render: SKIP (0.000s)
[195.600987] [038/133] (824s left) kms_frontbuffer_tracking (basic)
[195.690327] Starting subtest: basic
[199.155915] Subtest basic: SUCCESS (3.469s)
[199.296732] [039/133] (820s left) prime_vgem (sync)
[199.435100] Starting subtest: sync
[199.437230] Starting dynamic subtest: rcs0
[199.469473] Dynamic subtest rcs0: SUCCESS (0.034s)
[199.478239] Starting dynamic subtest: bcs0
[199.527542] Dynamic subtest bcs0: SUCCESS (0.057s)
[199.535880] Starting dynamic subtest: vcs0
[199.574877] Dynamic subtest vcs0: SUCCESS (0.047s)
[199.582915] Starting dynamic subtest: vcs1
[199.620525] Dynamic subtest vcs1: SUCCESS (0.045s)
[199.628774] Starting dynamic subtest: vecs0
[199.666487] Dynamic subtest vecs0: SUCCESS (0.045s)
[199.674837] Starting dynamic subtest: ccs0
[199.712072] Dynamic subtest ccs0: SUCCESS (0.045s)
[199.713892] Subtest sync: SUCCESS (0.277s)
[199.821818] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[199.825466] [040/133] (820s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[199.943045] Starting subtest: cursorA-vs-flipA-atomic
[211.083136] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.136s)
[211.920300] [041/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[212.018453] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[219.147187] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.133s)
[219.250737] [042/133] (801s left) prime_vgem (basic-gtt)
[219.333238] Starting subtest: basic-gtt
[219.337925] Subtest basic-gtt: SKIP (0.000s)
[219.450995] [043/133] (800s left) gem_ctx_persistence (hostile)
[219.507209] Starting subtest: hostile
[229.663057] Subtest hostile: SUCCESS (10.150s)
[229.789117] [044/133] (790s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[230.182526] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[230.969816] [045/133] (789s left) kms_frontbuffer_tracking (psr-1p-rte)
[231.079417] Starting subtest: psr-1p-rte
[236.502984] Subtest psr-1p-rte: SUCCESS (5.428s)
[236.639126] [046/133] (783s left) kms_psr (fbc-pr-primary-mmap-gtt)
[236.740280] Starting subtest: fbc-pr-primary-mmap-gtt
[236.744265] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[236.813170] [047/133] (783s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[236.937228] Starting subtest: cursorB-vs-flipB-atomic
[236.942901] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[237.094620] [048/133] (783s left) gem_eio (in-flight-internal-10ms)
[237.285661] Starting subtest: in-flight-internal-10ms
[238.376932] Subtest in-flight-internal-10ms: SUCCESS (1.091s)
[238.496016] [049/133] (782s left) kms_cursor_crc (cursor-offscreen-64x64)
[238.678750] Starting subtest: cursor-offscreen-64x64
[238.684355] Starting dynamic subtest: pipe-A-eDP-1
[240.626222] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[240.656169] Starting dynamic subtest: pipe-D-eDP-1
[243.238644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[243.241152] Subtest cursor-offscreen-64x64: SUCCESS (4.560s)
[244.073961] [050/133] (776s left) gen7_exec_parse (oacontrol-tracking)
[244.136534] Subtest oacontrol-tracking: SKIP (0.000s)
[244.206761] [051/133] (776s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[244.292531] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[244.294867] Starting dynamic subtest: pipe-A-default-mode
[245.433692] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[245.438248] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.140s)
[245.569076] [052/133] (775s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[245.661109] Starting subtest: disable-crc-after-crtc
[245.663473] Starting dynamic subtest: pipe-A-eDP-1
[247.352241] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.689s)
[247.362673] Starting dynamic subtest: pipe-B-eDP-1
[249.710246] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.358s)
[249.720361] Starting dynamic subtest: pipe-C-eDP-1
[251.955656] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[251.966037] Starting dynamic subtest: pipe-D-eDP-1
[254.227601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.273s)
[254.230082] Subtest disable-crc-after-crtc: SUCCESS (8.568s)
[255.054731] [053/133] (765s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[255.149196] Starting subtest: primary-yf-tiled-reflect-x-0
[255.210563] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[255.317618] [054/133] (765s left) gem_ctx_persistence (engines-hang)
[255.376877] Starting subtest: engines-hang
[255.379237] Starting dynamic subtest: rcs0
[255.501610] Dynamic subtest rcs0: SUCCESS (0.124s)
[255.514126] Starting dynamic subtest: bcs0
[255.620243] Dynamic subtest bcs0: SUCCESS (0.116s)
[255.631845] Starting dynamic subtest: vcs0
[255.721797] Dynamic subtest vcs0: SUCCESS (0.100s)
[255.733046] Starting dynamic subtest: vcs1
[255.816206] Dynamic subtest vcs1: SUCCESS (0.093s)
[255.827634] Starting dynamic subtest: vecs0
[255.899655] Dynamic subtest vecs0: SUCCESS (0.081s)
[255.910537] Starting dynamic subtest: ccs0
[256.022908] Dynamic subtest ccs0: SUCCESS (0.121s)
[256.025265] Subtest engines-hang: SUCCESS (0.647s)
[256.106213] [055/133] (764s left) gem_eio (in-flight-1us)
[256.329869] Starting subtest: in-flight-1us
[265.033580] Subtest in-flight-1us: SUCCESS (8.702s)
[265.200252] [056/133] (755s left) gem_mmap_wc (pf-nonblock)
[265.261828] Subtest pf-nonblock: SKIP (0.000s)
[265.330641] [057/133] (755s left) kms_flip (plain-flip-fb-recreate-interruptible)
[265.419887] Starting subtest: plain-flip-fb-recreate-interruptible
[265.422274] Starting dynamic subtest: A-eDP1
[274.245459] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[274.256208] Starting dynamic subtest: B-eDP1
[283.066660] Dynamic subtest B-eDP1: SUCCESS (8.819s)
[283.076536] Starting dynamic subtest: C-eDP1
[291.873596] Dynamic subtest C-eDP1: SUCCESS (8.806s)
[291.885163] Starting dynamic subtest: D-eDP1
[300.712647] Dynamic subtest D-eDP1: SUCCESS (8.836s)
[300.717029] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.295s)
[301.897972] [058/133] (719s left) gem_exec_reloc (basic-wc-gtt-active)
[301.952172] Subtest basic-wc-gtt-active: SKIP (0.000s)
[302.025471] [059/133] (719s left) kms_async_flips (async-flip-hang)
[302.119157] Starting subtest: async-flip-hang
[302.497112] Starting dynamic subtest: pipe-A-eDP-1
[328.837238] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.337s)
[329.218055] Starting dynamic subtest: pipe-B-eDP-1
[344.769580] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.557s)
[345.143622] Starting dynamic subtest: pipe-C-eDP-1
[360.764224] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.624s)
[361.147916] Starting dynamic subtest: pipe-D-eDP-1
[376.768448] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[376.771087] Subtest async-flip-hang: SUCCESS (74.645s)
[377.932443] [060/133] (643s left) gem_exec_flush (basic-wb-set-default)
[377.996398] Starting subtest: basic-wb-set-default
[383.447554] Subtest basic-wb-set-default: SUCCESS (5.453s)
[383.633457] [061/133] (637s left) kms_cursor_edge_walk (128x128-top-edge)
[383.735747] Starting subtest: 128x128-top-edge
[383.738511] Starting dynamic subtest: pipe-A-eDP-1
[387.198084] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[387.208801] Starting dynamic subtest: pipe-D-eDP-1
[390.326187] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[390.328529] Subtest 128x128-top-edge: SUCCESS (6.591s)
[391.124392] [062/133] (630s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[391.233993] Starting subtest: x-tiled-8bpp-rotate-180
[392.480405] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[392.605468] [063/133] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[392.702290] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[392.705738] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[392.821505] [064/133] (628s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[392.908280] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[392.910297] Starting dynamic subtest: pipe-A-eDP-1
[392.929776] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.940719] Starting dynamic subtest: pipe-B-eDP-1
[392.958239] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[392.966981] Starting dynamic subtest: pipe-C-eDP-1
[392.984234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[392.993718] Starting dynamic subtest: pipe-D-eDP-1
[393.011378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.014804] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[395.204119] [065/133] (626s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[395.301663] Starting subtest: 4-tiled-32bpp-rotate-180
[396.792237] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.490s)
[396.914558] [066/133] (624s left) gem_exec_fence (syncobj-channel)
[397.341806] Starting subtest: syncobj-channel
[398.364864] Subtest syncobj-channel: SUCCESS (1.020s)
[398.673336] [067/133] (622s left) kms_mmap_write_crc (main)
[398.765276] Starting subtest: main
[398.767601] Starting dynamic subtest: pipe-A-eDP-1
[402.281353] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.513s)
[402.283824] Subtest main: SUCCESS (3.515s)
[403.146080] [068/133] (618s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[403.253818] Starting subtest: y-tiled-32bpp-rotate-180
[403.258331] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[403.358734] [069/133] (618s left) kms_pm_rpm (fences-dpms)
[405.484571] Starting subtest: fences-dpms
[405.490284] Subtest fences-dpms: SKIP (0.000s)
[405.863657] [070/133] (615s left) gem_ctx_param (set-priority-range)
[405.921314] Starting subtest: set-priority-range
[405.935237] Subtest set-priority-range: SUCCESS (0.014s)
[406.033902] [071/133] (615s left) api_intel_allocator (alloc-simple)
[406.091792] Starting subtest: alloc-simple
[406.094189] Subtest alloc-simple: SUCCESS (0.003s)
[406.218339] [072/133] (615s left) gem_exec_schedule (preempt-other-chain)
[406.285373] Starting subtest: preempt-other-chain
[406.287597] Starting dynamic subtest: rcs0
[406.365860] Dynamic subtest rcs0: SUCCESS (0.087s)
[406.375666] Starting dynamic subtest: bcs0
[406.448197] Dynamic subtest bcs0: SUCCESS (0.082s)
[406.464309] Starting dynamic subtest: vcs0
[406.528719] Dynamic subtest vcs0: SUCCESS (0.079s)
[406.543175] Starting dynamic subtest: vcs1
[406.616842] Dynamic subtest vcs1: SUCCESS (0.087s)
[406.628099] Starting dynamic subtest: vecs0
[406.705087] Dynamic subtest vecs0: SUCCESS (0.088s)
[406.714545] Starting dynamic subtest: ccs0
[406.788988] Dynamic subtest ccs0: SUCCESS (0.083s)
[406.791665] Subtest preempt-other-chain: SUCCESS (0.511s)
[408.477943] [073/133] (613s left) kms_addfb_basic (too-wide)
[408.576566] Starting subtest: too-wide
[408.578469] Subtest too-wide: SUCCESS (0.000s)
[408.670729] [074/133] (613s left) gem_userptr_blits (set-cache-level)
[408.733392] Starting subtest: set-cache-level
[408.738099] Subtest set-cache-level: SKIP (0.000s)
[408.873682] [075/133] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[408.967318] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[408.971287] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[409.076143] [076/133] (612s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[409.171190] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[409.173469] Starting dynamic subtest: pipe-A-eDP-1
[409.182493] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[409.193212] Starting dynamic subtest: pipe-B-eDP-1
[409.202160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[409.211731] Starting dynamic subtest: pipe-C-eDP-1
[409.220169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[409.229271] Starting dynamic subtest: pipe-D-eDP-1
[409.237623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[409.241729] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[411.349076] [077/133] (610s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[411.445402] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[411.458092] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[411.535221] [078/133] (610s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[411.619294] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[411.645095] Starting dynamic subtest: pipe-A-plane-0
[412.333483] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[412.344931] Starting dynamic subtest: pipe-A-plane-3
[412.758062] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[413.845861] Starting dynamic subtest: pipe-B-plane-0
[414.515925] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s)
[414.525385] Starting dynamic subtest: pipe-B-plane-3
[414.937835] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[415.262692] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.644s)
[416.127103] [079/133] (605s left) gem_exec_params (rsvd2-dirt)
[416.198940] Starting subtest: rsvd2-dirt
[416.203426] Subtest rsvd2-dirt: SKIP (0.000s)
[416.300374] [080/133] (605s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[416.397469] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[416.399908] Starting dynamic subtest: pipe-A-eDP-1
[416.920467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[416.932821] Starting dynamic subtest: pipe-B-eDP-1
[418.422738] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.501s)
[418.438785] Starting dynamic subtest: pipe-C-eDP-1
[419.884280] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s)
[419.896717] Starting dynamic subtest: pipe-D-eDP-1
[421.296363] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[421.298729] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.870s)
[422.466784] [081/133] (599s left) kms_big_fb (linear-16bpp-rotate-90)
[422.574805] Starting subtest: linear-16bpp-rotate-90
[422.598694] Subtest linear-16bpp-rotate-90: SKIP (0.023s)
[422.712790] [082/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[422.813785] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[430.423341] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.612s)
[430.571810] [083/133] (591s left) kms_chamelium_audio (dp-audio)
[430.962791] Subtest dp-audio: SKIP (0.000s)
[431.739632] [084/133] (590s left) gem_bad_reloc (negative-reloc-lut)
[431.797556] Subtest negative-reloc-lut: SKIP (0.000s)
[431.871116] [085/133] (590s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[431.972525] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[431.976504] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[432.058658] [086/133] (590s left) i915_hangman (detector)
[432.126667] Starting subtest: detector
[432.128880] Starting dynamic subtest: rcs0
[443.267032] Dynamic subtest rcs0: SUCCESS (11.140s)
[443.280343] Starting dynamic subtest: bcs0
[455.299321] Dynamic subtest bcs0: SUCCESS (12.029s)
[455.312035] Starting dynamic subtest: vcs0
[467.331074] Dynamic subtest vcs0: SUCCESS (12.029s)
[467.344040] Starting dynamic subtest: vcs1
[477.251880] Dynamic subtest vcs1: SUCCESS (9.918s)
[477.266060] Starting dynamic subtest: vecs0
[489.282974] Dynamic subtest vecs0: SUCCESS (12.028s)
[489.300995] Starting dynamic subtest: ccs0
[500.291441] Dynamic subtest ccs0: SUCCESS (11.005s)
[500.294500] Subtest detector: SUCCESS (68.165s)
[500.376503] [087/133] (521s left) sysfs_heartbeat_interval (mixed)
[500.439156] Starting subtest: mixed
[500.441457] Starting dynamic subtest: vecs0
[505.672350] Dynamic subtest vecs0: SUCCESS (5.232s)
[505.684941] Starting dynamic subtest: ccs0
[510.852295] Dynamic subtest ccs0: SUCCESS (5.178s)
[510.865721] Starting dynamic subtest: vcs0
[516.059352] Dynamic subtest vcs0: SUCCESS (5.205s)
[516.070277] Starting dynamic subtest: bcs0
[521.264577] Dynamic subtest bcs0: SUCCESS (5.203s)
[521.275556] Starting dynamic subtest: rcs0
[526.475809] Dynamic subtest rcs0: SUCCESS (5.210s)
[526.488945] Starting dynamic subtest: vcs1
[531.694475] Dynamic subtest vcs1: SUCCESS (5.217s)
[531.697109] Subtest mixed: SUCCESS (31.255s)
[531.769912] [088/133] (490s left) kms_universal_plane (universal-plane-pageflip-windowed)
[531.857767] Starting subtest: universal-plane-pageflip-windowed
[531.859920] Starting dynamic subtest: pipe-A-eDP-1
[532.465660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[532.475857] Starting dynamic subtest: pipe-B-eDP-1
[533.697853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[533.708820] Starting dynamic subtest: pipe-C-eDP-1
[534.934104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[534.944772] Starting dynamic subtest: pipe-D-eDP-1
[536.157664] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[536.160235] Subtest universal-plane-pageflip-windowed: SUCCESS (4.299s)
[537.012615] [089/133] (485s left) kms_dp_link_training (uhbr-sst)
[537.102640] Starting subtest: uhbr-sst
[537.111356] Subtest uhbr-sst: SKIP (0.000s)
[537.174650] [090/133] (485s left) gem_exec_balancer (bonded-pair)
[537.233579] Starting subtest: bonded-pair
[537.239062] Subtest bonded-pair: SKIP (0.000s)
[537.549989] [091/133] (484s left) gem_exec_fence (invalid-fence-array)
[537.989759] Starting subtest: invalid-fence-array
[537.995758] Subtest invalid-fence-array: SUCCESS (0.002s)
[539.446840] [092/133] (483s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[539.546192] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[539.550627] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[539.651082] [093/133] (482s left) kms_psr (psr-cursor-plane-onoff)
[539.738912] Starting subtest: psr-cursor-plane-onoff
[539.741199] Starting dynamic subtest: eDP-1
[541.498900] Dynamic subtest eDP-1: SUCCESS (1.757s)
[541.500852] Subtest psr-cursor-plane-onoff: SUCCESS (1.758s)
[542.389134] [094/133] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[542.495728] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[542.500357] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[542.593134] [095/133] (480s left) kms_busy (basic)
[542.692220] Starting subtest: basic
[542.694537] Starting dynamic subtest: flip
[543.326579] Dynamic subtest flip: SUCCESS (0.633s)
[543.336665] Starting dynamic subtest: modeset
[546.809268] Dynamic subtest modeset: SUCCESS (3.482s)
[546.811674] Subtest basic: SUCCESS (4.118s)
[547.618442] [096/133] (475s left) gem_exec_async (forked-writes)
[547.675872] Starting subtest: forked-writes
[547.678664] Starting dynamic subtest: rcs0
[547.703472] Dynamic subtest rcs0: SUCCESS (0.028s)
[547.717180] Starting dynamic subtest: bcs0
[547.728385] Dynamic subtest bcs0: SUCCESS (0.024s)
[547.738582] Starting dynamic subtest: vcs0
[547.750760] Dynamic subtest vcs0: SUCCESS (0.022s)
[547.761942] Starting dynamic subtest: vcs1
[547.775338] Dynamic subtest vcs1: SUCCESS (0.024s)
[547.786221] Starting dynamic subtest: vecs0
[547.797995] Dynamic subtest vecs0: SUCCESS (0.022s)
[547.808483] Starting dynamic subtest: ccs0
[547.821880] Dynamic subtest ccs0: SUCCESS (0.023s)
[547.824168] Subtest forked-writes: SUCCESS (0.147s)
[548.042426] [097/133] (474s left) prime_vgem (coherency-gtt)
[548.116765] Starting subtest: coherency-gtt
[548.121561] Subtest coherency-gtt: SKIP (0.000s)
[548.232945] [098/133] (474s left) kms_properties (colorop-properties-legacy)
[548.331905] Starting subtest: colorop-properties-legacy
[548.334272] Starting dynamic subtest: pipe-A-eDP-1
[548.706905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[548.717383] Starting dynamic subtest: pipe-B-eDP-1
[549.777648] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.070s)
[549.788748] Starting dynamic subtest: pipe-C-eDP-1
[550.816313] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[550.827483] Starting dynamic subtest: pipe-D-eDP-1
[551.853656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.035s)
[551.855765] Subtest colorop-properties-legacy: SUCCESS (3.523s)
[552.665594] [099/133] (470s left) gem_mmap_wc (set-cache-level)
[552.725617] Subtest set-cache-level: SKIP (0.000s)
[552.791242] [100/133] (470s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[552.891936] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[559.814214] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.925s)
[559.956157] [101/133] (462s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[560.047330] Starting subtest: fbc-psr2-primary-mmap-cpu
[560.049679] Starting dynamic subtest: eDP-1
[560.053785] Dynamic subtest eDP-1: SKIP (0.000s)
[560.057958] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[560.129570] [102/133] (462s left) syncobj_timeline (32bits-limit)
[560.183768] Starting subtest: 32bits-limit
[560.186164] Subtest 32bits-limit: SUCCESS (0.001s)
[560.290609] [103/133] (462s left) perf_pmu (busy-accuracy-98)
[560.332442] Starting subtest: busy-accuracy-98
[560.334352] Starting dynamic subtest: rcs0
[563.370523] Dynamic subtest rcs0: SUCCESS (3.037s)
[563.381786] Starting dynamic subtest: bcs0
[566.427534] Dynamic subtest bcs0: SUCCESS (3.054s)
[566.438733] Starting dynamic subtest: vcs0
[569.467234] Dynamic subtest vcs0: SUCCESS (3.038s)
[569.478518] Starting dynamic subtest: vcs1
[572.511882] Dynamic subtest vcs1: SUCCESS (3.042s)
[572.523391] Starting dynamic subtest: vecs0
[575.558507] Dynamic subtest vecs0: SUCCESS (3.043s)
[575.570909] Starting dynamic subtest: ccs0
[578.611292] Dynamic subtest ccs0: SUCCESS (3.051s)
[578.613750] Subtest busy-accuracy-98: SUCCESS (18.278s)
[578.723558] [104/133] (444s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[578.827992] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[578.830321] Starting dynamic subtest: pipe-A
[578.850697] Dynamic subtest pipe-A: SKIP (0.019s)
[578.860836] Starting dynamic subtest: pipe-B
[578.886167] Dynamic subtest pipe-B: SKIP (0.034s)
[578.900698] Starting dynamic subtest: pipe-C
[578.919042] Dynamic subtest pipe-C: SKIP (0.033s)
[578.928762] Starting dynamic subtest: pipe-D
[578.953608] Dynamic subtest pipe-D: SKIP (0.033s)
[578.958045] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.122s)
[579.066447] [105/133] (443s left) gem_exec_whisper (basic-normal-all)
[579.129592] Starting subtest: basic-normal-all
[581.439366] Subtest basic-normal-all: SUCCESS (2.307s)
[581.622746] [106/133] (441s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[581.750101] Starting subtest: verify-pxp-execution-after-suspend-resume
[589.664557] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.916s)
[600.820512] [107/133] (433s left) gem_exec_reloc (basic-range-active)
[600.894602] Subtest basic-range-active: SKIP (0.000s)
[600.956187] [108/133] (433s left) kms_content_protection (dp-mst-type-1)
[601.096014] Starting subtest: dp-mst-type-1
[601.100668] Subtest dp-mst-type-1: SKIP (0.000s)
[601.209955] [109/133] (433s left) kms_invalid_mode (bad-htotal)
[601.302473] Starting subtest: bad-htotal
[601.304727] Starting dynamic subtest: pipe-A-eDP-1
[601.605744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[601.616471] Starting dynamic subtest: pipe-B-eDP-1
[601.618753] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[601.629592] Starting dynamic subtest: pipe-C-eDP-1
[601.632262] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[601.643782] Starting dynamic subtest: pipe-D-eDP-1
[601.646240] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[601.648633] Subtest bad-htotal: SUCCESS (0.311s)
[602.441995] [110/133] (431s left) gem_userptr_blits (unsync-unmap-after-close)
[602.505382] Subtest unsync-unmap-after-close: SKIP (0.000s)
[602.625534] [111/133] (431s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[602.719503] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[602.723906] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[602.810262] [112/133] (431s left) gem_exec_whisper (basic-queues-priority)
[602.877556] Starting subtest: basic-queues-priority
[627.313036] Subtest basic-queues-priority: SUCCESS (24.433s)
[627.502429] [113/133] (406s left) kms_flip (2x-flip-vs-suspend)
[627.602264] Starting subtest: 2x-flip-vs-suspend
[627.606320] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[627.714746] [114/133] (406s left) gem_ctx_engines (execute-one)
[627.764730] Starting subtest: execute-one
[630.078786] Subtest execute-one: SUCCESS (2.314s)
[630.364553] [115/133] (404s left) kms_color_pipeline (plane-ctm3x4)
[630.466948] Starting subtest: plane-ctm3x4
[630.625550] Starting dynamic subtest: pipe-A-plane-0
[630.768893] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[630.779749] Starting dynamic subtest: pipe-A-plane-1
[630.902445] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[630.912741] Starting dynamic subtest: pipe-A-plane-2
[631.036797] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[632.251109] Starting dynamic subtest: pipe-B-plane-0
[632.406818] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[632.417248] Starting dynamic subtest: pipe-B-plane-1
[632.562299] Dynamic subtest pipe-B-plane-1: SUCCESS (0.154s)
[632.573206] Starting dynamic subtest: pipe-B-plane-2
[632.694866] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[633.880620] Starting dynamic subtest: pipe-C-plane-0
[633.992792] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[634.003905] Starting dynamic subtest: pipe-C-plane-1
[634.115055] Dynamic subtest pipe-C-plane-1: SUCCESS (0.121s)
[634.125801] Starting dynamic subtest: pipe-C-plane-2
[634.248208] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[635.401757] Starting dynamic subtest: pipe-D-plane-0
[635.524117] Dynamic subtest pipe-D-plane-0: SUCCESS (0.132s)
[635.534994] Starting dynamic subtest: pipe-D-plane-1
[635.657888] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[635.668779] Starting dynamic subtest: pipe-D-plane-2
[635.780052] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[636.069515] Subtest plane-ctm3x4: SUCCESS (5.600s)
[636.885871] [116/133] (397s left) kms_plane (plane-position-hole-dpms)
[636.980478] Starting subtest: plane-position-hole-dpms
[637.517463] Starting dynamic subtest: pipe-A-plane-1
[639.904976] Dynamic subtest pipe-A-plane-1: SUCCESS (2.390s)
[639.916959] Starting dynamic subtest: pipe-A-plane-2
[642.333964] Dynamic subtest pipe-A-plane-2: SUCCESS (2.427s)
[642.345667] Starting dynamic subtest: pipe-A-plane-3
[644.718575] Dynamic subtest pipe-A-plane-3: SUCCESS (2.382s)
[644.729228] Starting dynamic subtest: pipe-A-plane-4
[647.202208] Dynamic subtest pipe-A-plane-4: SUCCESS (2.483s)
[647.213288] Starting dynamic subtest: pipe-A-plane-5
[647.226211] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[648.453371] Starting dynamic subtest: pipe-B-plane-1
[650.859403] Dynamic subtest pipe-B-plane-1: SUCCESS (2.414s)
[650.870084] Starting dynamic subtest: pipe-B-plane-2
[653.219178] Dynamic subtest pipe-B-plane-2: SUCCESS (2.359s)
[653.229718] Starting dynamic subtest: pipe-B-plane-3
[655.589741] Dynamic subtest pipe-B-plane-3: SUCCESS (2.369s)
[655.600837] Starting dynamic subtest: pipe-B-plane-4
[657.996028] Dynamic subtest pipe-B-plane-4: SUCCESS (2.405s)
[658.006472] Starting dynamic subtest: pipe-B-plane-5
[658.020417] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[658.022693] Subtest plane-position-hole-dpms: SUCCESS (21.040s)
[658.875106] [117/133] (375s left) kms_plane_cursor (primary)
[658.966402] Starting subtest: primary
[658.970719] Starting dynamic subtest: pipe-A-eDP-1-size-64
[661.530057] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.564s)
[661.555033] Starting dynamic subtest: pipe-A-eDP-1-size-128
[664.153885] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.607s)
[664.179066] Starting dynamic subtest: pipe-A-eDP-1-size-256
[666.742779] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[667.058961] Starting dynamic subtest: pipe-B-eDP-1-size-64
[670.393034] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.344s)
[670.420209] Starting dynamic subtest: pipe-B-eDP-1-size-128
[673.005169] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[673.031492] Starting dynamic subtest: pipe-B-eDP-1-size-256
[675.616313] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s)
[675.934389] Starting dynamic subtest: pipe-C-eDP-1-size-64
[678.873365] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.951s)
[678.901743] Starting dynamic subtest: pipe-C-eDP-1-size-128
[681.129098] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[681.157585] Starting dynamic subtest: pipe-C-eDP-1-size-256
[683.407510] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s)
[683.731726] Starting dynamic subtest: pipe-D-eDP-1-size-64
[686.667469] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.947s)
[686.695493] Starting dynamic subtest: pipe-D-eDP-1-size-128
[688.911995] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[688.939950] Starting dynamic subtest: pipe-D-eDP-1-size-256
[691.190342] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.259s)
[691.501315] Subtest primary: SUCCESS (32.535s)
[692.320147] [118/133] (342s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[692.425016] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[692.429588] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[692.533062] [119/133] (342s left) gen9_exec_parse (unaligned-access)
[692.593431] Subtest unaligned-access: SKIP (0.000s)
[692.676506] [120/133] (342s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[692.734930] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[692.739108] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[692.912849] [121/133] (341s left) kms_cursor_crc (cursor-random-64x64)
[693.085750] Starting subtest: cursor-random-64x64
[693.088243] Starting dynamic subtest: pipe-A-eDP-1
[696.632257] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.544s)
[696.667724] Starting dynamic subtest: pipe-D-eDP-1
[700.618225] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.960s)
[700.620652] Subtest cursor-random-64x64: SUCCESS (7.534s)
[701.492764] [122/133] (333s left) dumb_buffer (create-valid-dumb)
[701.538409] Starting subtest: create-valid-dumb
[701.540636] Subtest create-valid-dumb: SUCCESS (0.000s)
[701.627359] [123/133] (333s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[701.680459] Starting subtest: etime-multi-wait-all-submitted-signaled
[701.785186] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[701.865700] [124/133] (333s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[701.958469] Starting subtest: 4-tiled-16bpp-rotate-180
[703.204097] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.246s)
[703.336212] [125/133] (331s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[703.437166] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[703.440664] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[703.542119] [126/133] (331s left) i915_pm_rc6_residency (rc6-idle)
[703.599927] Starting subtest: rc6-idle
[703.626371] Starting dynamic subtest: gt0-rcs0
[728.060536] Dynamic subtest gt0-rcs0: SUCCESS (24.433s)
[728.071545] Starting dynamic subtest: gt0-bcs0
[752.275231] Dynamic subtest gt0-bcs0: SUCCESS (24.212s)
[752.285938] Starting dynamic subtest: gt0-ccs0
[776.552849] Dynamic subtest gt0-ccs0: SUCCESS (24.275s)
[776.563556] Starting dynamic subtest: gt1-vcs0
[782.726425] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[782.740076] Starting dynamic subtest: gt1-vecs0
[788.898603] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[788.901295] Subtest rc6-idle: SUCCESS (85.298s)
[788.995787] [127/133] (246s left) kms_pm_rpm (universal-planes-dpms)
[790.534906] Starting subtest: universal-planes-dpms
[790.537074] Starting dynamic subtest: plane-35
[798.842680] Dynamic subtest plane-35: SUCCESS (8.308s)
[798.856374] Starting dynamic subtest: plane-65
[807.162815] Dynamic subtest plane-65: SUCCESS (8.317s)
[807.176163] Starting dynamic subtest: plane-95
[815.494213] Dynamic subtest plane-95: SUCCESS (8.328s)
[815.507967] Starting dynamic subtest: plane-125
[823.893285] Dynamic subtest plane-125: SUCCESS (8.396s)
[823.907524] Starting dynamic subtest: plane-135
[832.214268] Dynamic subtest plane-135: SUCCESS (8.318s)
[832.227547] Starting dynamic subtest: plane-145
[840.917765] Dynamic subtest plane-145: SUCCESS (8.700s)
[840.920731] Subtest universal-planes-dpms: SUCCESS (50.385s)
[841.313854] [128/133] (193s left) gem_mmap_offset (bad-object)
[841.363868] Starting subtest: bad-object
[841.366308] Subtest bad-object: SUCCESS (0.001s)
[841.459701] [129/133] (193s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[841.568021] Starting subtest: fbc-modesetfrombusy
[845.358045] Subtest fbc-modesetfrombusy: SUCCESS (3.794s)
[846.571604] [130/133] (188s left) kms_properties (invalid-properties-legacy)
[846.655306] Starting subtest: invalid-properties-legacy
[846.764066] Subtest invalid-properties-legacy: SUCCESS (0.107s)
[846.837304] [131/133] (188s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[846.887902] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[846.890165] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[846.997418] [132/133] (188s left) gem_softpin (evict-single-offset)
[847.051157] Starting subtest: evict-single-offset
[874.340389] Subtest evict-single-offset: SUCCESS (27.287s)
[874.440781] [133/133] (160s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[874.585462] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[874.589849] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[874.692172] 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.