[62.590657] Initializing watchdogs
[62.590707]   /dev/watchdog0
[62.605884] [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]
[62.610317] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.613589] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.616884] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[62.741491] Starting subtest: fbcpsr-indfb-scaledprimary
[68.523605] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.785s)
[68.671969] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[68.765751] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[75.674908] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.911s)
[75.845185] [003/133] (947s left) prime_mmap (test_correct)
[75.924992] Starting subtest: test_correct
[75.927021] Starting dynamic subtest: test_correct-smem
[75.956873] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[75.959296] Subtest test_correct: SUCCESS (0.033s)
[76.050460] [004/133] (947s left) gem_exec_reloc (basic-write-read)
[76.110988] Subtest basic-write-read: SKIP (0.000s)
[76.178347] [005/133] (947s left) gem_ctx_isolation (preservation)
[76.241253] Starting subtest: preservation
[76.243613] Starting dynamic subtest: rcs0
[76.389021] Dynamic subtest rcs0: SUCCESS (0.146s)
[76.397639] Starting dynamic subtest: bcs0
[76.534017] Dynamic subtest bcs0: SUCCESS (0.145s)
[76.543304] Starting dynamic subtest: vcs0
[76.685026] Dynamic subtest vcs0: SUCCESS (0.151s)
[76.692763] Starting dynamic subtest: vcs1
[78.392067] Dynamic subtest vcs1: SUCCESS (1.706s)
[78.402477] Starting dynamic subtest: vecs0
[80.490291] Dynamic subtest vecs0: SUCCESS (2.098s)
[80.502346] Starting dynamic subtest: ccs0
[82.470551] Dynamic subtest ccs0: SUCCESS (1.980s)
[82.473357] Subtest preservation: SUCCESS (6.229s)
[82.696660] [006/133] (940s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[82.804309] Starting subtest: x-tiled-16bpp-rotate-270
[82.823664] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[82.960824] [007/133] (940s left) gem_exec_fence (long-history)
[83.393622] Starting subtest: long-history
[91.066244] Subtest long-history: SUCCESS (7.674s)
[91.587389] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[91.590920] [008/133] (931s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[91.683700] Starting subtest: primary-yf-tiled-reflect-x-180
[91.745849] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[91.846709] [009/133] (931s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[91.918129] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[91.920569] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[92.027585] [010/133] (931s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[92.125993] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[92.130199] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[92.192225] [011/133] (931s left) gem_exec_flush (basic-uc-set-default)
[92.258651] Starting subtest: basic-uc-set-default
[97.743368] Subtest basic-uc-set-default: SUCCESS (5.455s)
[97.898116] [012/133] (925s left) gem_ctx_bad_destroy (double-destroy)
[97.960697] Starting subtest: double-destroy
[97.963096] Subtest double-destroy: SUCCESS (0.000s)
[98.035419] [013/133] (925s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[98.133712] Starting subtest: y-tiled-32bpp-rotate-0
[98.137722] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[98.215835] [014/133] (925s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[98.329502] Starting subtest: 2x-flip-vs-cursor-legacy
[98.334275] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.004s)
[98.494230] [015/133] (925s left) kms_cursor_crc (cursor-random-256x256)
[98.728481] Starting subtest: cursor-random-256x256
[98.732491] Starting dynamic subtest: pipe-A-eDP-1
[102.087530] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.354s)
[102.119576] Starting dynamic subtest: pipe-D-eDP-1
[106.066517] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.952s)
[106.068777] Subtest cursor-random-256x256: SUCCESS (7.335s)
[106.946776] [016/133] (916s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[107.325835] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[108.148636] [017/133] (915s left) gem_ctx_shared (q-independent)
[108.209036] Starting subtest: Q-independent
[108.211487] Starting dynamic subtest: rcs0
[108.272786] Dynamic subtest rcs0: SUCCESS (0.063s)
[108.284028] Starting dynamic subtest: vcs0
[108.314846] Dynamic subtest vcs0: SUCCESS (0.042s)
[108.324655] Starting dynamic subtest: vcs1
[108.362658] Dynamic subtest vcs1: SUCCESS (0.048s)
[108.370622] Starting dynamic subtest: vecs0
[108.398892] Dynamic subtest vecs0: SUCCESS (0.036s)
[108.408780] Starting dynamic subtest: ccs0
[108.441703] Dynamic subtest ccs0: SUCCESS (0.043s)
[108.444079] Subtest Q-independent: SUCCESS (0.233s)
[110.387079] [018/133] (913s left) gem_ctx_param (basic-default)
[110.444372] Starting subtest: basic-default
[110.446833] Subtest basic-default: SUCCESS (0.000s)
[110.518783] [019/133] (913s left) gem_exec_schedule (preempt-queue-contexts-chain)
[110.593999] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[110.880411] [020/133] (912s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[110.975760] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[110.978158] Starting dynamic subtest: pipe-A-eDP-1
[111.001379] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.010202] Starting dynamic subtest: pipe-B-eDP-1
[111.031053] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.038266] Starting dynamic subtest: pipe-C-eDP-1
[111.059623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[111.067194] Starting dynamic subtest: pipe-D-eDP-1
[111.088868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[111.093170] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[113.220064] [021/133] (910s left) kms_addfb_basic (tile-pitch-mismatch)
[113.284680] Starting subtest: tile-pitch-mismatch
[113.289151] Subtest tile-pitch-mismatch: SKIP (0.000s)
[113.411489] [022/133] (910s left) kms_cursor_crc (cursor-suspend)
[113.534601] Starting subtest: cursor-suspend
[113.536814] Starting dynamic subtest: pipe-A-eDP-1
[147.779240] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.008s)
[147.789576] Starting dynamic subtest: pipe-D-eDP-1
[182.789385] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.568s)
[182.791668] Subtest cursor-suspend: SUCCESS (8.579s)
[192.643634] [023/133] (840s left) core_getversion (basic)
[192.702215] Starting subtest: basic
[192.706791] Subtest basic: SUCCESS (0.000s)
[192.779603] [024/133] (840s left) gem_pread (bench)
[192.840583] Subtest bench: SKIP (0.000s)
[192.945500] [025/133] (840s left) gen9_exec_parse (bb-start-far)
[193.022610] Subtest bb-start-far: SKIP (0.000s)
[193.119802] [026/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[193.226087] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[193.230378] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[193.366318] [027/133] (839s left) gem_ctx_param (get-priority-new-ctx)
[193.424726] Starting subtest: get-priority-new-ctx
[193.427118] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[193.536301] [028/133] (839s left) kms_big_fb (linear-8bpp-rotate-90)
[193.634430] Starting subtest: linear-8bpp-rotate-90
[193.656961] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[193.779093] [029/133] (839s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[193.876048] Starting subtest: basic-modeset-with-all-modifiers-formats
[194.260281] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[195.004269] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.745s)
[195.013199] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[195.025406] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[195.034047] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[195.047696] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[195.056342] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[195.203322] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[195.212833] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[195.225239] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[195.234020] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[195.247924] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[195.257195] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[195.270148] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[195.278731] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[195.292177] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[195.300583] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[195.314522] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[195.323073] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[195.336717] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[195.345327] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[195.358832] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[195.367073] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[195.381581] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[195.393046] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[195.536712] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[195.546698] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[195.558952] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[195.567965] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[195.581105] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[195.589593] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[195.603346] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[195.611995] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[195.625654] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[195.634161] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[195.647959] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[195.656591] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[195.669884] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[195.678495] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[195.692468] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[195.700834] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[195.714683] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[195.723309] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[195.859227] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.144s)
[195.869046] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[195.881221] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[195.891302] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[195.903664] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[195.912793] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[195.925764] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[195.934077] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[195.948324] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[195.959833] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[195.970227] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[195.978496] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[195.992486] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[196.000808] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[196.014702] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[196.022956] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[196.036874] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[196.430955] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.555s)
[197.197847] [030/133] (836s left) gem_exec_balancer (persistence)
[197.467783] Starting subtest: persistence
[198.378054] Subtest persistence: SUCCESS (0.910s)
[198.495265] [031/133] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[198.602140] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[198.606445] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[198.698514] [032/133] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[198.805454] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[198.809671] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[198.904445] [033/133] (834s left) i915_pm_rpm (gem-pread)
[201.134444] Starting subtest: gem-pread
[203.177658] Subtest gem-pread: SUCCESS (2.044s)
[203.277467] [034/133] (830s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[205.206790] Starting subtest: dpms-mode-unset-lpsp
[209.269044] Subtest dpms-mode-unset-lpsp: SUCCESS (4.065s)
[209.671270] [035/133] (823s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[209.726072] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[209.730826] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[209.923642] [036/133] (823s left) gem_exec_whisper (basic-queues-priority)
[209.989350] Starting subtest: basic-queues-priority
[233.204755] Subtest basic-queues-priority: SUCCESS (23.209s)
[233.387326] [037/133] (800s left) kms_addfb_basic (addfb25-modifier-no-flag)
[233.490811] Starting subtest: addfb25-modifier-no-flag
[233.493056] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[233.580638] [038/133] (800s left) kms_flip (dpms-off-confusion-interruptible)
[233.674618] Starting subtest: dpms-off-confusion-interruptible
[233.677024] Starting dynamic subtest: A-eDP1
[242.383714] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[242.394063] Starting dynamic subtest: B-eDP1
[251.008188] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[251.017577] Starting dynamic subtest: C-eDP1
[259.636681] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[259.647306] Starting dynamic subtest: D-eDP1
[268.273373] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[268.275878] Subtest dpms-off-confusion-interruptible: SUCCESS (34.555s)
[269.399211] [039/133] (764s left) kms_flip (flip-vs-panning-vs-hang)
[269.494023] Starting subtest: flip-vs-panning-vs-hang
[269.496353] Starting dynamic subtest: A-eDP1
[321.546570] Dynamic subtest A-eDP1: SUCCESS (52.049s)
[321.556044] Starting dynamic subtest: D-eDP1
[361.487534] Dynamic subtest D-eDP1: SUCCESS (39.937s)
[361.492336] Subtest flip-vs-panning-vs-hang: SUCCESS (91.992s)
[362.698641] [040/133] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[362.788065] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[369.326655] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.541s)
[369.442512] [041/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[369.549827] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[377.024204] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.478s)
[377.176515] [042/133] (656s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[377.286080] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[377.290132] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[377.362199] [043/133] (656s left) gem_userptr_blits (create-destroy-unsync)
[377.436928] Subtest create-destroy-unsync: SKIP (0.000s)
[377.553078] [044/133] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[377.645640] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[377.649945] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.730303] [045/133] (656s left) kms_psr (fbc-pr-sprite-render)
[377.828063] Starting subtest: fbc-pr-sprite-render
[377.832408] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[377.901259] [046/133] (656s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[377.993200] Starting subtest: psr2-plane-move-sf-dmg-area
[377.995061] Starting dynamic subtest: pipe-A-eDP-1
[382.513458] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.522s)
[382.524871] Starting dynamic subtest: pipe-B-eDP-1
[387.831577] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.317s)
[387.834035] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.842s)
[388.714001] [047/133] (645s left) kms_psr (psr-primary-blt)
[388.802998] Starting subtest: psr-primary-blt
[388.805427] Starting dynamic subtest: eDP-1
[390.508514] Dynamic subtest eDP-1: SUCCESS (1.708s)
[390.510964] Subtest psr-primary-blt: SUCCESS (1.709s)
[391.385573] [048/133] (642s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[391.493659] Starting subtest: fbc-psr-sprite-mmap-cpu
[391.496019] Starting dynamic subtest: eDP-1
[391.500225] Dynamic subtest eDP-1: SKIP (0.000s)
[391.504410] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[391.566929] [049/133] (642s left) i915_drm_fdinfo (memory-info-idle)
[391.612267] Starting subtest: memory-info-idle
[391.614445] Starting dynamic subtest: smem0
[391.682358] Dynamic subtest smem0: SUCCESS (0.070s)
[391.684880] Subtest memory-info-idle: SUCCESS (0.071s)
[391.760867] [050/133] (642s left) kms_plane_scaling (invalid-parameters)
[391.865952] Starting subtest: invalid-parameters
[391.868267] Starting dynamic subtest: less-than-1-height-src
[391.878784] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[391.889915] Starting dynamic subtest: less-than-1-width-src
[391.892279] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[391.894575] Subtest invalid-parameters: SUCCESS (0.028s)
[392.013109] [051/133] (642s left) gem_exec_reloc (basic-gtt-active)
[392.062993] Subtest basic-gtt-active: SKIP (0.000s)
[392.133630] [052/133] (642s left) gem_mmap_gtt (close-race)
[392.185372] Subtest close-race: SKIP (0.000s)
[392.245486] [053/133] (642s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[392.332067] Starting subtest: compare-crc-sanitycheck-nv12
[392.333954] Starting dynamic subtest: pipe-A-eDP-1
[393.049714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[393.060465] Starting dynamic subtest: pipe-B-eDP-1
[394.388368] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[394.398645] Starting dynamic subtest: pipe-C-eDP-1
[395.638879] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.249s)
[395.651346] Starting dynamic subtest: pipe-D-eDP-1
[396.873025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[396.875649] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.542s)
[397.708766] [054/133] (636s left) api_intel_allocator (fork-simple-once)
[397.770828] Starting subtest: fork-simple-once
[397.784640] Subtest fork-simple-once: SUCCESS (0.017s)
[397.905599] [055/133] (636s left) kms_vrr (max-min)
[397.993821] Starting subtest: max-min
[397.999831] Subtest max-min: SKIP (0.000s)
[398.068682] [056/133] (636s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[398.155134] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[398.159365] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[398.242121] [057/133] (636s left) gem_exec_params (sol-reset-invalid)
[398.290362] Starting subtest: sol-reset-invalid
[398.294979] Subtest sol-reset-invalid: SUCCESS (0.003s)
[400.022521] [058/133] (634s left) kms_lease (invalid-create-leases)
[400.103624] Starting subtest: invalid-create-leases
[400.108220] Subtest invalid-create-leases: SUCCESS (0.006s)
[400.207536] [059/133] (634s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[400.281543] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[400.383944] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[400.473890] [060/133] (634s left) kms_psr (pr-primary-page-flip)
[400.579326] Starting subtest: pr-primary-page-flip
[400.583403] Subtest pr-primary-page-flip: SKIP (0.000s)
[400.655052] [061/133] (634s left) gem_exec_params (readonly)
[400.722201] Starting subtest: readonly
[400.724515] Subtest readonly: SUCCESS (0.003s)
[400.848233] [062/133] (633s left) gem_mmap_gtt (basic-copy)
[400.916679] Subtest basic-copy: SKIP (0.000s)
[400.994125] [063/133] (633s left) kms_psr (psr2-sprite-mmap-cpu)
[401.085970] Starting subtest: psr2-sprite-mmap-cpu
[401.088216] Starting dynamic subtest: eDP-1
[402.791418] Dynamic subtest eDP-1: SUCCESS (1.704s)
[402.793300] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.705s)
[403.655496] [064/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[403.756947] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[410.636878] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.882s)
[410.751773] [065/133] (624s left) drm_read (empty-nonblock)
[410.907693] Starting subtest: empty-nonblock
[410.910000] Subtest empty-nonblock: SUCCESS (0.000s)
[411.033040] [066/133] (623s left) perf_pmu (busy-no-semaphores)
[411.071498] Starting subtest: busy-no-semaphores
[411.073816] Starting dynamic subtest: rcs0
[411.632410] Dynamic subtest rcs0: SUCCESS (0.560s)
[411.644755] Starting dynamic subtest: bcs0
[412.182103] Dynamic subtest bcs0: SUCCESS (0.547s)
[412.194193] Starting dynamic subtest: vcs0
[412.731985] Dynamic subtest vcs0: SUCCESS (0.547s)
[412.744706] Starting dynamic subtest: vcs1
[414.502975] Dynamic subtest vcs1: SUCCESS (1.768s)
[414.514909] Starting dynamic subtest: vecs0
[416.487115] Dynamic subtest vecs0: SUCCESS (1.980s)
[416.499278] Starting dynamic subtest: ccs0
[418.535252] Dynamic subtest ccs0: SUCCESS (2.045s)
[418.538080] Subtest busy-no-semaphores: SUCCESS (7.465s)
[418.654576] [067/133] (616s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[418.754994] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[418.757376] Starting dynamic subtest: pipe-A-eDP-1
[418.766551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.776801] Starting dynamic subtest: pipe-B-eDP-1
[418.785986] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.795165] Starting dynamic subtest: pipe-C-eDP-1
[418.803702] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.812782] Starting dynamic subtest: pipe-D-eDP-1
[418.821229] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.825407] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[421.063810] [068/133] (613s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[421.152987] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[421.155268] Starting dynamic subtest: pipe-A-eDP-1
[421.178075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[421.189429] Starting dynamic subtest: pipe-B-eDP-1
[421.212327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[421.222755] Starting dynamic subtest: pipe-C-eDP-1
[421.244346] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[421.253597] Starting dynamic subtest: pipe-D-eDP-1
[421.275462] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[421.279848] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[423.424855] [069/133] (611s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[423.515022] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[423.517342] Starting dynamic subtest: pipe-A
[423.742091] Dynamic subtest pipe-A: SUCCESS (0.229s)
[423.751676] Starting dynamic subtest: pipe-B
[425.000869] Dynamic subtest pipe-B: SUCCESS (1.257s)
[425.013079] Starting dynamic subtest: pipe-C
[426.377593] Dynamic subtest pipe-C: SUCCESS (1.375s)
[426.387247] Starting dynamic subtest: pipe-D
[427.680090] Dynamic subtest pipe-D: SUCCESS (1.300s)
[427.682341] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.167s)
[428.871273] [070/133] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[428.968969] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[428.973385] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[429.087567] [071/133] (606s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[429.209351] Starting subtest: protected-encrypted-src-copy-not-readible
[429.320995] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[429.426501] [072/133] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[429.523941] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[433.467419] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.946s)
[434.676617] [073/133] (600s left) fbdev (read)
[434.717473] Starting subtest: read
[435.247336] Subtest read: SUCCESS (0.528s)
[435.308531] [074/133] (599s left) gem_exec_parallel (basic)
[435.369131] Starting subtest: basic
[435.371343] Starting dynamic subtest: rcs0
[436.800061] Dynamic subtest rcs0: SUCCESS (1.433s)
[436.810570] Starting dynamic subtest: bcs0
[438.276401] Dynamic subtest bcs0: SUCCESS (1.474s)
[438.288912] Starting dynamic subtest: vcs0
[439.982234] Dynamic subtest vcs0: SUCCESS (1.702s)
[439.994057] Starting dynamic subtest: vcs1
[441.955887] Dynamic subtest vcs1: SUCCESS (1.971s)
[441.968068] Starting dynamic subtest: vecs0
[443.939368] Dynamic subtest vecs0: SUCCESS (1.981s)
[443.951843] Starting dynamic subtest: ccs0
[445.428580] Dynamic subtest ccs0: SUCCESS (1.488s)
[445.430874] Subtest basic: SUCCESS (10.062s)
[445.618562] [075/133] (589s left) kms_dsc (dsc-with-formats)
[445.723388] Starting subtest: dsc-with-formats
[445.763511] Subtest dsc-with-formats: SKIP (0.001s)
[445.810014] [076/133] (589s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[445.903403] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[445.907512] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[445.990046] [077/133] (589s left) kms_cursor_crc (cursor-onscreen-512x512)
[446.274721] Starting subtest: cursor-onscreen-512x512
[446.279210] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[446.431798] [078/133] (588s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[446.530660] Starting subtest: plane-lut1d-pre-ctm3x4
[446.676442] Starting dynamic subtest: pipe-A-plane-0
[446.844092] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[446.853371] Starting dynamic subtest: pipe-A-plane-1
[447.032324] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[447.044130] Starting dynamic subtest: pipe-A-plane-2
[447.198703] Dynamic subtest pipe-A-plane-2: SUCCESS (0.165s)
[448.400659] Starting dynamic subtest: pipe-B-plane-0
[448.570453] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[448.580768] Starting dynamic subtest: pipe-B-plane-1
[448.759546] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[448.772841] Starting dynamic subtest: pipe-B-plane-2
[448.915700] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[450.127676] Starting dynamic subtest: pipe-C-plane-0
[450.276588] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[450.286891] Starting dynamic subtest: pipe-C-plane-1
[450.439483] Dynamic subtest pipe-C-plane-1: SUCCESS (0.165s)
[450.449525] Starting dynamic subtest: pipe-C-plane-2
[450.606046] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[451.853707] Starting dynamic subtest: pipe-D-plane-0
[452.011690] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[452.023828] Starting dynamic subtest: pipe-D-plane-1
[452.178557] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[452.188361] Starting dynamic subtest: pipe-D-plane-2
[452.345508] Dynamic subtest pipe-D-plane-2: SUCCESS (0.165s)
[452.636219] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.105s)
[453.517759] [079/133] (581s left) kms_invalid_mode (overflow-vrefresh)
[453.616500] Starting subtest: overflow-vrefresh
[453.618801] Starting dynamic subtest: pipe-A-eDP-1
[453.904578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[453.914822] Starting dynamic subtest: pipe-B-eDP-1
[453.917028] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[453.925976] Starting dynamic subtest: pipe-C-eDP-1
[453.928435] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[453.937708] Starting dynamic subtest: pipe-D-eDP-1
[453.939902] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[453.942063] Subtest overflow-vrefresh: SUCCESS (0.297s)
[454.739708] [080/133] (580s left) kms_async_flips (invalid-async-flip-atomic)
[454.839519] Starting subtest: invalid-async-flip-atomic
[455.215423] Starting dynamic subtest: pipe-A-eDP-1
[456.075626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s)
[456.434329] Starting dynamic subtest: pipe-B-eDP-1
[457.294798] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.869s)
[457.657646] Starting dynamic subtest: pipe-C-eDP-1
[458.427470] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[458.782895] Starting dynamic subtest: pipe-D-eDP-1
[459.556187] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[459.558589] Subtest invalid-async-flip-atomic: SUCCESS (4.719s)
[460.717990] [081/133] (574s left) kms_content_protection (dp-mst-type-0)
[460.854500] Starting subtest: dp-mst-type-0
[460.858969] Subtest dp-mst-type-0: SKIP (0.000s)
[460.971044] [082/133] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[461.064599] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[461.068747] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[461.169468] [083/133] (574s left) kms_getfb (getfb2-into-addfb2)
[461.269576] Starting subtest: getfb2-into-addfb2
[461.271855] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[461.378416] [084/133] (574s left) i915_module_load (resize-bar)
[461.418869] Starting subtest: resize-bar
[461.425721] Subtest resize-bar: SKIP (0.006s)
[461.476426] [085/133] (574s left) kms_flip (plain-flip-fb-recreate-interruptible)
[461.568807] Starting subtest: plain-flip-fb-recreate-interruptible
[461.571590] Starting dynamic subtest: A-eDP1
[470.400703] Dynamic subtest A-eDP1: SUCCESS (8.830s)
[470.413396] Starting dynamic subtest: B-eDP1
[479.240524] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[479.251499] Starting dynamic subtest: C-eDP1
[488.065700] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[488.077715] Starting dynamic subtest: D-eDP1
[496.895293] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[496.899507] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.327s)
[498.094802] [086/133] (537s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[498.207742] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[498.842979] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[499.017784] [087/133] (536s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[499.074541] Starting subtest: single-wait-for-submit-available-signaled
[499.077089] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[499.185356] [088/133] (536s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[499.282957] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[499.285558] Starting dynamic subtest: pipe-A-default-mode
[500.439372] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[500.443934] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.155s)
[500.578316] [089/133] (535s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[500.697425] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[500.701875] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[500.868376] [090/133] (535s left) gem_exec_schedule (preempt-queue)
[500.951223] Subtest preempt-queue: SKIP (0.000s)
[501.236842] [091/133] (534s left) kms_cdclk (mode-transition-all-outputs)
[501.325896] Starting subtest: mode-transition-all-outputs
[501.614526] Subtest mode-transition-all-outputs: SKIP (0.286s)
[502.427128] [092/133] (533s left) gem_workarounds (reset-fd)
[502.503911] Starting subtest: reset-fd
[502.686416] Subtest reset-fd: SUCCESS (0.182s)
[502.819398] [093/133] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[502.925829] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[502.930471] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[503.041905] [094/133] (533s left) gem_close_race (multigpu-basic-threads)
[503.113288] Starting subtest: multigpu-basic-threads
[503.117273] Subtest multigpu-basic-threads: SKIP (0.000s)
[503.335258] [095/133] (532s left) gem_exec_params (no-bsd)
[503.386455] Starting subtest: no-bsd
[503.388831] Subtest no-bsd: SUCCESS (0.002s)
[505.050521] [096/133] (531s left) kms_plane_multiple (2x-tiling-yf)
[505.141083] Starting subtest: 2x-tiling-yf
[505.145123] Subtest 2x-tiling-yf: SKIP (0.000s)
[505.228845] [097/133] (531s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[505.290754] Starting subtest: invalid-bsd2-flag-on-blt
[505.292646] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[505.392244] [098/133] (530s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[505.481244] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[510.310989] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.832s)
[511.434109] [099/133] (524s left) kms_pm_rpm (pm-tiling)
[513.157003] Starting subtest: pm-tiling
[513.162710] Subtest pm-tiling: SKIP (0.000s)
[513.665986] [100/133] (522s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[513.722629] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[513.823883] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[513.904465] [101/133] (522s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[513.963185] Starting subtest: invalid-multi-wait-unsubmitted
[513.965293] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[514.059262] [102/133] (522s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[514.146604] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[514.150570] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[514.249285] [103/133] (522s left) kms_chamelium_frames (hdmi-crc-single)
[514.648267] Subtest hdmi-crc-single: SKIP (0.000s)
[515.476395] [104/133] (521s left) syncobj_wait (multi-wait-submitted-signaled)
[515.524218] Starting subtest: multi-wait-submitted-signaled
[515.526590] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[515.606963] [105/133] (520s left) gem_userptr_blits (coherency-sync)
[515.673503] Starting subtest: coherency-sync
[516.047987] Subtest coherency-sync: SKIP (0.340s)
[516.153203] [106/133] (520s left) kms_vblank (ts-continuation-idle-hang)
[516.302115] Starting subtest: ts-continuation-idle-hang
[516.304443] Starting dynamic subtest: pipe-A-eDP-1
[542.757372] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.450s)
[542.772298] Starting dynamic subtest: pipe-D-eDP-1
[567.794554] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.033s)
[567.796743] Subtest ts-continuation-idle-hang: SUCCESS (51.488s)
[568.678865] [107/133] (468s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[568.773879] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[568.778132] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[568.878226] [108/133] (467s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[569.008898] Starting subtest: 2x-cursor-vs-flip-legacy
[569.013480] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[569.166833] [109/133] (467s left) gem_exec_balancer (parallel-balancer)
[569.418044] Starting subtest: parallel-balancer
[570.313145] Subtest parallel-balancer: SUCCESS (0.896s)
[570.423374] [110/133] (466s left) perf (stress-open-close)
[570.593603] Starting subtest: stress-open-close
[570.595425] Starting dynamic subtest: 0-rcs0
[572.759258] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[572.771216] Starting dynamic subtest: 1-vcs0
[574.923406] Dynamic subtest 1-vcs0: SUCCESS (2.163s)
[574.925260] Subtest stress-open-close: SUCCESS (4.333s)
[574.973844] [111/133] (461s left) gem_ctx_shared (create-shared-gtt)
[575.034765] Starting subtest: create-shared-gtt
[577.245155] Subtest create-shared-gtt: SUCCESS (2.155s)
[577.477979] [112/133] (459s left) kms_addfb_basic (small-bo)
[577.571748] Starting subtest: small-bo
[577.573593] Subtest small-bo: SUCCESS (0.000s)
[577.665079] [113/133] (459s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[577.764095] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[577.766290] Starting dynamic subtest: pipe-A-eDP-1
[577.786984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[577.799854] Starting dynamic subtest: pipe-B-eDP-1
[577.818099] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[577.827992] Starting dynamic subtest: pipe-C-eDP-1
[577.846729] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[577.858478] Starting dynamic subtest: pipe-D-eDP-1
[577.877357] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[577.879276] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[579.940491] [114/133] (457s left) syncobj_timeline (wait-delayed-signal)
[579.988786] Starting subtest: wait-delayed-signal
[580.090073] Subtest wait-delayed-signal: SUCCESS (0.102s)
[580.172304] [115/133] (456s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[580.267209] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[580.271186] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[580.361830] [116/133] (456s left) gem_mmap_gtt (hang-user)
[580.421925] Subtest hang-user: SKIP (0.000s)
[580.477426] [117/133] (456s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[580.523753] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[580.631707] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[580.710674] [118/133] (456s left) gem_tiled_wc
[580.833506] [119/133] (456s left) i915_pm_rps (thresholds-park)
[580.903913] Starting subtest: thresholds-park
[580.908272] Subtest thresholds-park: SKIP (0.000s)
[581.002275] [120/133] (456s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[581.086758] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[581.090929] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[581.180614] [121/133] (456s left) kms_busy (extended-pageflip-hang-newfb)
[581.272193] Starting subtest: extended-pageflip-hang-newfb
[581.274118] Starting dynamic subtest: pipe-A
[607.794079] Dynamic subtest pipe-A: SUCCESS (26.519s)
[607.806251] Starting dynamic subtest: pipe-D
[631.808532] Dynamic subtest pipe-D: SUCCESS (24.008s)
[631.810888] Subtest extended-pageflip-hang-newfb: SUCCESS (50.532s)
[632.616804] [122/133] (404s left) gem_spin_batch (engines)
[632.683105] Starting subtest: engines
[632.684928] Starting dynamic subtest: rcs0
[635.923085] Dynamic subtest rcs0: SUCCESS (3.237s)
[635.936027] Starting dynamic subtest: bcs0
[639.211902] Dynamic subtest bcs0: SUCCESS (3.235s)
[639.224608] Starting dynamic subtest: vcs0
[642.448618] Dynamic subtest vcs0: SUCCESS (3.234s)
[642.461901] Starting dynamic subtest: vcs1
[645.686458] Dynamic subtest vcs1: SUCCESS (3.235s)
[645.699439] Starting dynamic subtest: vecs0
[648.925056] Dynamic subtest vecs0: SUCCESS (3.235s)
[648.938258] Starting dynamic subtest: ccs0
[652.163285] Dynamic subtest ccs0: SUCCESS (3.235s)
[652.165517] Subtest engines: SUCCESS (19.427s)
[652.345675] [123/133] (385s left) kms_sequence (get-busy)
[652.443810] Starting subtest: get-busy
[652.445725] Starting dynamic subtest: pipe-A-eDP-1
[654.382002] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[654.392958] Starting dynamic subtest: pipe-B-eDP-1
[657.002676] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.620s)
[657.013097] Starting dynamic subtest: pipe-C-eDP-1
[659.618348] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s)
[659.629739] Starting dynamic subtest: pipe-D-eDP-1
[662.242164] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[662.244373] Subtest get-busy: SUCCESS (9.797s)
[663.042652] [124/133] (374s left) gem_exec_reloc (basic-cpu-read)
[663.110236] Subtest basic-cpu-read: SKIP (0.000s)
[663.178482] [125/133] (374s left) gem_exec_whisper (basic-forked-all)
[663.241103] Starting subtest: basic-forked-all
[677.029079] Subtest basic-forked-all: SUCCESS (13.786s)
[677.227726] [126/133] (360s left) kms_flip (basic-flip-vs-wf_vblank)
[677.325115] Starting subtest: basic-flip-vs-wf_vblank
[677.327471] Starting dynamic subtest: A-eDP1
[679.291713] Dynamic subtest A-eDP1: SUCCESS (1.969s)
[679.308203] Starting dynamic subtest: B-eDP1
[681.225733] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[681.240810] Starting dynamic subtest: C-eDP1
[683.146969] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[683.158908] Starting dynamic subtest: D-eDP1
[685.078119] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[685.080501] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.759s)
[686.308146] [127/133] (351s left) core_auth (getclient-simple)
[686.346545] Starting subtest: getclient-simple
[686.368443] Subtest getclient-simple: SUCCESS (0.026s)
[686.475992] [128/133] (351s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[686.571545] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[686.575943] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[686.675999] [129/133] (350s left) perf (low-oa-exponent-permissions)
[686.761591] Starting subtest: low-oa-exponent-permissions
[686.791550] Subtest low-oa-exponent-permissions: SUCCESS (0.030s)
[686.839868] [130/133] (350s left) gem_vm_create (execbuf)
[686.900263] Starting subtest: execbuf
[686.913245] Subtest execbuf: SUCCESS (0.013s)
[687.050845] [131/133] (350s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[687.153301] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[688.243622] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[688.369454] [132/133] (349s left) gem_mmap_gtt (basic-small-bo)
[688.416488] Subtest basic-small-bo: SKIP (0.000s)
[688.473212] [133/133] (349s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[688.572584] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[688.576064] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[688.678759] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: core_getversion
results: parsing output: 23/ for test: gem_pread
results: parsing output: 24/ for test: gen9_exec_parse
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_vrr
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: drm_read
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: fbdev
results: parsing output: 73/ for test: gem_exec_parallel
results: parsing output: 74/ for test: kms_dsc
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: i915_module_load
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_cdclk
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_chamelium_frames
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_tiled_wc
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_busy
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: core_auth
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_vm_create
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.