[56.749998] Initializing watchdogs
[56.750057]   /dev/watchdog0
[56.764438] [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]
[56.768873] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.771589] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.774816] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[56.902750] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[63.499868] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.600s)
[63.608109] [002/133] (953s left) syncobj_wait (wait-all-complex)
[63.669759] Starting subtest: wait-all-complex
[63.882277] Subtest wait-all-complex: SUCCESS (0.213s)
[63.968742] [003/133] (953s left) kms_cursor_edge_walk (256x256-right-edge)
[64.054985] Starting subtest: 256x256-right-edge
[64.057336] Starting dynamic subtest: pipe-A-eDP-1
[67.544202] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s)
[67.554726] Starting dynamic subtest: pipe-D-eDP-1
[70.664036] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[70.666510] Subtest 256x256-right-edge: SUCCESS (6.610s)
[71.464617] [004/133] (945s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[71.513423] Starting subtest: etime-multi-wait-all-available-unsubmitted
[71.620549] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[71.692467] [005/133] (945s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[71.749386] Starting subtest: y-tiled-ccs-to-y-tiled
[71.753817] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[71.942868] [006/133] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[72.034621] Starting subtest: fbcpsr-1p-rte
[79.073891] Subtest fbcpsr-1p-rte: SUCCESS (7.043s)
[79.258057] [007/133] (938s left) kms_mmap_write_crc (main)
[79.353620] Starting subtest: main
[79.355967] Starting dynamic subtest: pipe-A-eDP-1
[82.933531] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.579s)
[82.935537] Subtest main: SUCCESS (3.580s)
[83.728475] [008/133] (933s left) gen9_exec_parse (unaligned-access)
[83.802482] Subtest unaligned-access: SKIP (0.000s)
[83.871456] [009/133] (933s left) gem_ctx_isolation (preservation-reset)
[84.047804] Starting subtest: preservation-reset
[84.050635] Starting dynamic subtest: rcs0
[84.293085] Dynamic subtest rcs0: SUCCESS (0.246s)
[84.303534] Starting dynamic subtest: bcs0
[84.609526] Dynamic subtest bcs0: SUCCESS (0.316s)
[84.618701] Starting dynamic subtest: vcs0
[84.917451] Dynamic subtest vcs0: SUCCESS (0.307s)
[84.928699] Starting dynamic subtest: vcs1
[86.509444] Dynamic subtest vcs1: SUCCESS (1.591s)
[86.520571] Starting dynamic subtest: vecs0
[88.574095] Dynamic subtest vecs0: SUCCESS (2.064s)
[88.587992] Starting dynamic subtest: ccs0
[90.536819] Dynamic subtest ccs0: SUCCESS (1.963s)
[90.539314] Subtest preservation-reset: SUCCESS (6.492s)
[90.684833] [010/133] (926s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[90.797374] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[90.801786] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[90.865617] [011/133] (926s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[92.492444] Starting subtest: modeset-lpsp-stress-no-wait
[102.628750] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.137s)
[102.715116] [012/133] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[102.825441] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[102.829626] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.906285] [013/133] (914s left) kms_flip (nonblocking-read)
[103.012135] Starting subtest: nonblocking-read
[103.014344] Subtest nonblocking-read: SUCCESS (0.000s)
[103.109507] [014/133] (914s left) sriov_basic (enable-vfs-autoprobe-on)
[103.172077] Starting subtest: enable-vfs-autoprobe-on
[103.174290] Starting dynamic subtest: numvfs-1
[103.247790] Dynamic subtest numvfs-1: FAIL (0.013s)
[103.256766] Starting dynamic subtest: numvfs-2
[103.330745] Dynamic subtest numvfs-2: FAIL (0.004s)
[103.340612] Starting dynamic subtest: numvfs-3
[103.412949] Dynamic subtest numvfs-3: FAIL (0.004s)
[103.421607] Starting dynamic subtest: numvfs-4
[103.490043] Dynamic subtest numvfs-4: FAIL (0.004s)
[103.498623] Starting dynamic subtest: numvfs-5
[103.568634] Dynamic subtest numvfs-5: FAIL (0.003s)
[103.576803] Starting dynamic subtest: numvfs-6
[103.640685] Dynamic subtest numvfs-6: FAIL (0.003s)
[103.649120] Starting dynamic subtest: numvfs-7
[103.705773] Dynamic subtest numvfs-7: FAIL (0.003s)
[103.713482] Starting dynamic subtest: numvfs-random
[103.769784] Dynamic subtest numvfs-random: FAIL (0.003s)
[103.778027] Starting dynamic subtest: numvfs-all
[103.835153] Dynamic subtest numvfs-all: FAIL (0.476s)
[103.836698] Subtest enable-vfs-autoprobe-on: FAIL (0.518s)
[103.868897] [015/133] (913s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[103.963044] Starting subtest: pr-plane-move-sf-dmg-area
[103.966287] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[104.028118] [016/133] (913s left) gem_mmap_wc (bad-size)
[104.083535] Subtest bad-size: SKIP (0.000s)
[104.151220] [017/133] (913s left) gem_exec_reloc (basic-range)
[104.209119] Subtest basic-range: SKIP (0.000s)
[104.295437] [018/133] (913s left) gem_ctx_param (set-priority-range)
[104.342424] Starting subtest: set-priority-range
[104.356242] Subtest set-priority-range: SUCCESS (0.014s)
[104.481457] [019/133] (913s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[104.594258] Starting subtest: flip-vs-cursor-toggle
[113.508787] Subtest flip-vs-cursor-toggle: SUCCESS (8.912s)
[114.304743] [020/133] (903s left) kms_psr (fbc-psr2-dpms)
[114.396108] Starting subtest: fbc-psr2-dpms
[114.398046] Starting dynamic subtest: eDP-1
[114.402087] Dynamic subtest eDP-1: SKIP (0.000s)
[114.406077] Subtest fbc-psr2-dpms: SKIP (0.001s)
[114.466760] [021/133] (903s left) gem_exec_schedule (preempt-other-chain)
[114.540614] Starting subtest: preempt-other-chain
[114.542500] Starting dynamic subtest: rcs0
[114.617282] Dynamic subtest rcs0: SUCCESS (0.083s)
[114.631089] Starting dynamic subtest: bcs0
[114.699196] Dynamic subtest bcs0: SUCCESS (0.082s)
[114.713735] Starting dynamic subtest: vcs0
[114.779524] Dynamic subtest vcs0: SUCCESS (0.078s)
[114.794495] Starting dynamic subtest: vcs1
[114.858962] Dynamic subtest vcs1: SUCCESS (0.080s)
[114.872073] Starting dynamic subtest: vecs0
[114.941302] Dynamic subtest vecs0: SUCCESS (0.081s)
[114.953694] Starting dynamic subtest: ccs0
[115.031902] Dynamic subtest ccs0: SUCCESS (0.091s)
[115.034298] Subtest preempt-other-chain: SUCCESS (0.498s)
[116.368177] [022/133] (901s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[116.461073] Starting subtest: fbc-dirtyfb-ioctl
[116.463650] Starting dynamic subtest: A-eDP-1
[119.063247] Dynamic subtest A-eDP-1: SUCCESS (2.600s)
[119.065397] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.601s)
[119.872879] [023/133] (898s left) perf_pmu (render-node-busy)
[119.946913] Starting subtest: render-node-busy
[119.949383] Starting dynamic subtest: rcs0
[120.529070] Dynamic subtest rcs0: SUCCESS (0.581s)
[120.542085] Starting dynamic subtest: bcs0
[121.085526] Dynamic subtest bcs0: SUCCESS (0.555s)
[121.097904] Starting dynamic subtest: vcs0
[122.303642] Dynamic subtest vcs0: SUCCESS (1.215s)
[122.316656] Starting dynamic subtest: vcs1
[124.289408] Dynamic subtest vcs1: SUCCESS (1.984s)
[124.301201] Starting dynamic subtest: vecs0
[126.273055] Dynamic subtest vecs0: SUCCESS (1.982s)
[126.285682] Starting dynamic subtest: ccs0
[126.835045] Dynamic subtest ccs0: SUCCESS (0.561s)
[126.837905] Subtest render-node-busy: SUCCESS (6.888s)
[126.910866] [024/133] (891s left) kms_invalid_mode (uint-max-clock)
[127.012446] Starting subtest: uint-max-clock
[127.014855] Starting dynamic subtest: pipe-A-eDP-1
[127.299258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[127.310064] Starting dynamic subtest: pipe-B-eDP-1
[127.312375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[127.321813] Starting dynamic subtest: pipe-C-eDP-1
[127.323766] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[127.332855] Starting dynamic subtest: pipe-D-eDP-1
[127.334723] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[127.336584] Subtest uint-max-clock: SUCCESS (0.294s)
[128.105082] [025/133] (890s left) gem_exec_capture (userptr)
[128.170852] Starting subtest: userptr
[128.992070] Subtest userptr: SUCCESS (0.820s)
[129.100038] [026/133] (889s left) sysfs_timeslice_duration (duration)
[129.154618] Starting subtest: duration
[129.157360] Starting dynamic subtest: vecs0
[144.225691] Dynamic subtest vecs0: SUCCESS (15.067s)
[144.241095] Starting dynamic subtest: ccs0
[157.363322] Dynamic subtest ccs0: SUCCESS (13.137s)
[157.375109] Starting dynamic subtest: vcs0
[172.253467] Dynamic subtest vcs0: SUCCESS (14.885s)
[172.270407] Starting dynamic subtest: bcs0
[185.391906] Dynamic subtest bcs0: SUCCESS (13.137s)
[185.405087] Starting dynamic subtest: rcs0
[198.538678] Dynamic subtest rcs0: SUCCESS (13.144s)
[198.551028] Starting dynamic subtest: vcs1
[212.190898] Dynamic subtest vcs1: SUCCESS (13.648s)
[212.193763] Subtest duration: SUCCESS (83.030s)
[212.277175] [027/133] (806s left) syncobj_timeline (single-wait-available-signaled)
[212.329118] Starting subtest: single-wait-available-signaled
[212.331325] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[212.411407] [028/133] (805s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[212.505806] Starting subtest: basic-max-pipe-crc-check
[212.510226] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[212.550277] [029/133] (805s left) kms_draw_crc (draw-method-pwrite)
[212.643280] Starting subtest: draw-method-pwrite
[212.645219] Starting dynamic subtest: xrgb8888-untiled
[213.219842] Dynamic subtest xrgb8888-untiled: SUCCESS (0.577s)
[213.230480] Starting dynamic subtest: rgb565-untiled
[213.697855] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[213.707577] Starting dynamic subtest: xrgb2101010-untiled
[214.264029] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[214.273298] Starting dynamic subtest: xbgr16161616f-untiled
[215.052661] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.787s)
[215.062483] Starting dynamic subtest: xrgb8888-xtiled
[216.864346] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.809s)
[216.874140] Starting dynamic subtest: rgb565-xtiled
[217.964288] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[217.976312] Starting dynamic subtest: xrgb2101010-xtiled
[219.774977] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.811s)
[219.784559] Starting dynamic subtest: xbgr16161616f-xtiled
[223.130648] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.355s)
[223.140433] Starting dynamic subtest: xrgb8888-4tiled
[224.264075] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.133s)
[224.274357] Starting dynamic subtest: rgb565-4tiled
[224.842574] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[224.853235] Starting dynamic subtest: xrgb2101010-4tiled
[225.952900] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.110s)
[225.962391] Starting dynamic subtest: xbgr16161616f-4tiled
[228.986561] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.033s)
[228.988856] Subtest draw-method-pwrite: SUCCESS (16.345s)
[229.088500] [030/133] (789s left) gem_exec_reloc (basic-cpu-noreloc)
[229.143735] Subtest basic-cpu-noreloc: SKIP (0.000s)
[229.225063] [031/133] (789s left) gem_ctx_exec (basic-nohangcheck)
[229.281166] Starting subtest: basic-nohangcheck
[229.531962] Subtest basic-nohangcheck: SUCCESS (0.252s)
[229.641774] [032/133] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[229.736204] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[229.738504] Starting dynamic subtest: pipe-A-default-mode
[232.440530] Dynamic subtest pipe-A-default-mode: SUCCESS (2.703s)
[232.442775] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.705s)
[233.293240] [033/133] (785s left) kms_chamelium_color (degamma)
[233.391189] Subtest degamma: SKIP (0.000s)
[233.433677] [034/133] (785s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[233.530485] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[233.532799] Starting dynamic subtest: pipe-A-eDP-1
[233.556338] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.568278] Starting dynamic subtest: pipe-B-eDP-1
[233.589984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.599563] Starting dynamic subtest: pipe-C-eDP-1
[233.621590] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.631069] Starting dynamic subtest: pipe-D-eDP-1
[233.653288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.657345] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[235.766227] [035/133] (782s left) gem_exec_whisper (basic-forked-all)
[235.827595] Starting subtest: basic-forked-all
[249.280467] Subtest basic-forked-all: SUCCESS (13.451s)
[249.485316] [036/133] (769s left) perf_pmu (busy)
[249.523919] Starting subtest: busy
[249.526309] Starting dynamic subtest: rcs0
[250.105895] Dynamic subtest rcs0: SUCCESS (0.582s)
[250.117781] Starting dynamic subtest: bcs0
[250.678805] Dynamic subtest bcs0: SUCCESS (0.571s)
[250.690050] Starting dynamic subtest: vcs0
[252.287563] Dynamic subtest vcs0: SUCCESS (1.605s)
[252.299209] Starting dynamic subtest: vcs1
[254.271733] Dynamic subtest vcs1: SUCCESS (1.982s)
[254.281855] Starting dynamic subtest: vecs0
[256.319840] Dynamic subtest vecs0: SUCCESS (2.046s)
[256.330931] Starting dynamic subtest: ccs0
[256.883554] Dynamic subtest ccs0: SUCCESS (0.562s)
[256.886214] Subtest busy: SUCCESS (7.361s)
[256.989180] [037/133] (761s left) syncobj_timeline (multi-wait-available-signaled)
[257.040923] Starting subtest: multi-wait-available-signaled
[257.043808] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[257.141040] [038/133] (761s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[257.273327] Starting subtest: flip-vs-cursor-busy-crc-atomic
[257.979856] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.704s)
[258.801427] [039/133] (760s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[258.899074] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[258.903310] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[258.969441] [040/133] (759s left) i915_query (query-regions-garbage-items)
[259.019677] Starting subtest: query-regions-garbage-items
[259.021766] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[259.132566] [041/133] (759s left) gem_flink_basic (double-flink)
[259.186394] Starting subtest: double-flink
[259.188346] Subtest double-flink: SUCCESS (0.000s)
[259.299128] [042/133] (759s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[259.386272] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[259.397272] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[259.484404] [043/133] (759s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[259.571078] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[259.578516] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[259.654816] [044/133] (759s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[259.760606] Starting subtest: async-flip-with-page-flip-events-tiled
[260.144813] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[262.872277] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.726s)
[262.883522] Starting dynamic subtest: pipe-A-eDP-1-4
[265.047034] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[265.059987] Starting dynamic subtest: pipe-A-eDP-1-4
[267.056808] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[267.069114] Starting dynamic subtest: pipe-A-eDP-1-x
[269.235617] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[269.604452] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[272.403608] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[272.413553] Starting dynamic subtest: pipe-B-eDP-1-4
[274.589536] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[274.602391] Starting dynamic subtest: pipe-B-eDP-1-4
[276.600087] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[276.613025] Starting dynamic subtest: pipe-B-eDP-1-x
[278.789654] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[279.158234] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[281.925842] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.777s)
[281.936738] Starting dynamic subtest: pipe-C-eDP-1-4
[284.100860] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[284.110832] Starting dynamic subtest: pipe-C-eDP-1-4
[286.111590] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[286.121549] Starting dynamic subtest: pipe-C-eDP-1-x
[288.290278] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[288.657321] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[291.456799] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[291.468747] Starting dynamic subtest: pipe-D-eDP-1-4
[293.641382] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[293.651085] Starting dynamic subtest: pipe-D-eDP-1-4
[295.652481] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[295.662130] Starting dynamic subtest: pipe-D-eDP-1-x
[297.831185] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[297.834109] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.070s)
[299.037356] [045/133] (720s left) kms_sequence (queue-idle)
[299.138258] Starting subtest: queue-idle
[299.140389] Starting dynamic subtest: pipe-A-eDP-1
[300.954443] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[300.965297] Starting dynamic subtest: pipe-B-eDP-1
[303.418528] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.462s)
[303.429155] Starting dynamic subtest: pipe-C-eDP-1
[305.842568] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[305.853495] Starting dynamic subtest: pipe-D-eDP-1
[308.281959] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[308.284340] Subtest queue-idle: SUCCESS (9.144s)
[309.092397] [046/133] (709s left) gem_ctx_bad_destroy (invalid-ctx)
[309.145838] Starting subtest: invalid-ctx
[309.148094] Subtest invalid-ctx: SUCCESS (0.000s)
[309.214890] [047/133] (709s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[309.302282] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[309.304523] Starting dynamic subtest: pipe-A
[309.322277] Dynamic subtest pipe-A: SKIP (0.017s)
[309.332869] Starting dynamic subtest: pipe-B
[309.353398] Dynamic subtest pipe-B: SKIP (0.030s)
[309.363279] Starting dynamic subtest: pipe-C
[309.386247] Dynamic subtest pipe-C: SKIP (0.030s)
[309.395985] Starting dynamic subtest: pipe-D
[309.415429] Dynamic subtest pipe-D: SKIP (0.030s)
[309.419095] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.110s)
[309.516380] [048/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[309.610715] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[309.615084] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[309.688244] [049/133] (709s left) gem_exec_basic (basic)
[309.736086] Starting subtest: basic
[309.738378] Starting dynamic subtest: rcs0-smem
[309.740777] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[309.750274] Starting dynamic subtest: bcs0-smem
[309.752609] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[309.761879] Starting dynamic subtest: vcs0-smem
[309.764092] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[309.773202] Starting dynamic subtest: vcs1-smem
[309.775401] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[309.784609] Starting dynamic subtest: vecs0-smem
[309.786838] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[309.795904] Starting dynamic subtest: ccs0-smem
[309.798145] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[309.800330] Subtest basic: SUCCESS (0.015s)
[311.333249] [050/133] (707s left) api_intel_allocator (two-level-inception)
[311.381771] Starting subtest: two-level-inception
[316.778060] Subtest two-level-inception: SUCCESS (5.399s)
[316.911881] [051/133] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[317.023297] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[317.027751] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[317.135410] [052/133] (702s left) gen9_exec_parse (basic-rejected-ctx-param)
[317.200785] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[317.293622] [053/133] (702s left) gem_ccs (large-ctrl-surf-copy)
[317.354332] Starting subtest: large-ctrl-surf-copy
[317.358861] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[317.455427] [054/133] (701s left) gem_exec_schedule (submit-golden-slice)
[317.529423] Starting subtest: submit-golden-slice
[317.531732] Starting dynamic subtest: rcs0
[317.560777] Dynamic subtest rcs0: SUCCESS (0.038s)
[317.571666] Starting dynamic subtest: bcs0
[317.606067] Dynamic subtest bcs0: SUCCESS (0.045s)
[317.618799] Starting dynamic subtest: vcs0
[317.652470] Dynamic subtest vcs0: SUCCESS (0.045s)
[317.664221] Starting dynamic subtest: vcs1
[317.694193] Dynamic subtest vcs1: SUCCESS (0.041s)
[317.706913] Starting dynamic subtest: vecs0
[317.737289] Dynamic subtest vecs0: SUCCESS (0.042s)
[317.748308] Starting dynamic subtest: ccs0
[317.780558] Dynamic subtest ccs0: SUCCESS (0.042s)
[317.783101] Subtest submit-golden-slice: SUCCESS (0.259s)
[319.396483] [055/133] (700s left) kms_addfb_basic (bad-pitch-0)
[319.453244] Starting subtest: bad-pitch-0
[319.455492] Subtest bad-pitch-0: SUCCESS (0.000s)
[319.624166] [056/133] (699s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[319.731981] Starting subtest: pipe-fbc-rte
[319.738583] Starting dynamic subtest: pipe-B-eDP-1
[325.144054] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.414s)
[325.152298] Subtest pipe-fbc-rte: SUCCESS (5.418s)
[327.416887] [057/133] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[327.521839] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[327.526229] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[327.611087] [058/133] (691s left) gem_mmap_offset (pf-nonblock)
[327.656646] Starting subtest: pf-nonblock
[327.662426] Subtest pf-nonblock: SUCCESS (0.006s)
[327.776724] [059/133] (691s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[327.870053] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[327.872398] Starting dynamic subtest: pipe-A-eDP-1
[360.382174] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.803s)
[360.393788] Starting dynamic subtest: pipe-B-eDP-1
[393.300614] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.679s)
[393.313362] Starting dynamic subtest: pipe-C-eDP-1
[426.275241] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.726s)
[426.286807] Starting dynamic subtest: pipe-D-eDP-1
[459.276993] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.619s)
[459.279246] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.832s)
[460.519925] [060/133] (559s left) kms_psr (psr-dpms)
[460.627759] Starting subtest: psr-dpms
[460.630060] Starting dynamic subtest: eDP-1
[463.635424] Dynamic subtest eDP-1: SUCCESS (3.002s)
[463.637760] Subtest psr-dpms: SUCCESS (3.003s)
[464.500263] [061/133] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[464.595715] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[464.599694] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.691966] [062/133] (555s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[464.796981] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[464.808700] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[464.900057] [063/133] (554s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[464.941081] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[464.984938] [064/133] (554s left) gem_exec_await (wide-contexts)
[465.214709] Starting subtest: wide-contexts
[488.827659] Subtest wide-contexts: SUCCESS (23.595s)
[489.036445] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[489.042172] [065/133] (530s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[489.196158] Starting subtest: y-tiled-8bpp-rotate-270
[489.200507] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[489.300132] [066/133] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[489.401161] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[489.405321] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[489.513355] [067/133] (530s left) i915_pm_rps (min-max-config-idle)
[489.584118] Starting subtest: min-max-config-idle
[489.588934] Subtest min-max-config-idle: SKIP (0.000s)
[489.700050] [068/133] (530s left) gem_lmem_swapping (verify-random)
[489.751059] Subtest verify-random: SKIP (0.000s)
[489.795065] [069/133] (530s left) gem_pxp (protected-raw-src-copy-not-readible)
[489.911092] Starting subtest: protected-raw-src-copy-not-readible
[489.967661] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[490.085437] [070/133] (530s left) kms_psr (psr2-primary-blt)
[490.177265] Starting subtest: psr2-primary-blt
[490.179204] Starting dynamic subtest: eDP-1
[491.882719] Dynamic subtest eDP-1: SUCCESS (1.704s)
[491.884654] Subtest psr2-primary-blt: SUCCESS (1.705s)
[492.766254] [071/133] (527s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[492.864706] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[492.869328] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[492.978356] [072/133] (527s left) kms_psr (fbc-psr-primary-mmap-cpu)
[493.070647] Starting subtest: fbc-psr-primary-mmap-cpu
[493.072971] Starting dynamic subtest: eDP-1
[493.077340] Dynamic subtest eDP-1: SKIP (0.000s)
[493.081724] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[493.146514] [073/133] (527s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[493.236149] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[493.238387] Starting dynamic subtest: pipe-A-eDP-1
[493.310260] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[493.323449] Starting dynamic subtest: pipe-B-eDP-1
[494.435942] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[494.440232] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.204s)
[495.631172] [074/133] (524s left) kms_properties (invalid-properties-atomic)
[495.727494] Starting subtest: invalid-properties-atomic
[496.014174] Subtest invalid-properties-atomic: SUCCESS (0.287s)
[496.088692] [075/133] (524s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[496.184233] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[496.188369] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[496.260001] [076/133] (524s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[496.316400] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[496.375986] [077/133] (524s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[496.476998] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[496.479255] Starting dynamic subtest: pipe-A-eDP-1
[502.311978] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.840s)
[502.323585] Starting dynamic subtest: pipe-B-eDP-1
[508.988993] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.674s)
[508.991291] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.517s)
[509.856193] [078/133] (510s left) kms_cursor_crc (cursor-size-change)
[509.956744] Starting subtest: cursor-size-change
[509.958593] Starting dynamic subtest: pipe-A-eDP-1
[510.788562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[510.800811] Starting dynamic subtest: pipe-D-eDP-1
[512.221977] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s)
[512.223790] Subtest cursor-size-change: SUCCESS (2.265s)
[513.028694] [079/133] (507s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[513.146640] Starting subtest: flip-vs-cursor-atomic
[520.575813] Subtest flip-vs-cursor-atomic: SUCCESS (7.425s)
[521.463615] [080/133] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[521.573497] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[528.096303] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.527s)
[528.221275] [081/133] (492s left) gem_ctx_persistence (userptr)
[528.281102] Starting subtest: userptr
[528.466815] Subtest userptr: SUCCESS (0.185s)
[528.563868] [082/133] (492s left) gem_close (many-handles-one-vma)
[528.625335] Starting subtest: many-handles-one-vma
[528.651103] Subtest many-handles-one-vma: SUCCESS (0.026s)
[528.769941] [083/133] (491s left) kms_atomic (atomic-plane-damage)
[528.854111] Starting subtest: atomic-plane-damage
[528.901075] Starting dynamic subtest: pipe-A-eDP-1
[529.436810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[529.439155] Subtest atomic-plane-damage: SUCCESS (0.585s)
[530.307908] [084/133] (490s left) kms_getfb (getfb-handle-not-fb)
[530.408633] Starting subtest: getfb-handle-not-fb
[530.410961] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[530.515354] [085/133] (490s left) kms_color (ctm-max)
[530.611810] Starting subtest: ctm-max
[530.613904] Starting dynamic subtest: pipe-A-eDP-1
[531.326038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[531.338072] Starting dynamic subtest: pipe-B-eDP-1
[532.712996] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[532.724816] Starting dynamic subtest: pipe-C-eDP-1
[534.095910] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[534.107928] Starting dynamic subtest: pipe-D-eDP-1
[535.435925] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[535.438531] Subtest ctm-max: SUCCESS (4.827s)
[536.246192] [086/133] (484s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[536.343321] Starting subtest: fbc-modesetfrombusy
[540.104780] Subtest fbc-modesetfrombusy: SUCCESS (3.766s)
[541.293142] [087/133] (479s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[541.386314] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[541.390417] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[541.486528] [088/133] (479s left) kms_flip (2x-plain-flip-fb-recreate)
[541.576971] Starting subtest: 2x-plain-flip-fb-recreate
[541.585273] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[541.667545] [089/133] (479s left) api_intel_bb (lot-of-buffers)
[541.729814] Starting subtest: lot-of-buffers
[542.776721] Subtest lot-of-buffers: SUCCESS (1.047s)
[543.122043] [090/133] (477s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[543.220303] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[547.637504] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.421s)
[548.805352] [091/133] (472s left) kms_plane (pixel-format-y-tiled-modifier)
[548.906793] Starting subtest: pixel-format-y-tiled-modifier
[548.910967] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[548.980071] [092/133] (472s left) kms_hdr (bpc-switch-suspend)
[549.074812] Starting subtest: bpc-switch-suspend
[550.161605] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[569.248903] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.418s)
[570.308479] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[590.236779] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.562s)
[590.239128] Subtest bpc-switch-suspend: SUCCESS (12.113s)
[590.360689] [093/133] (430s left) sw_sync (sync_busy_fork_unixsocket)
[590.406514] Starting subtest: sync_busy_fork_unixsocket
[590.412845] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[590.474480] [094/133] (430s left) gem_render_copy (y-tiled-to-vebox-linear)
[590.537349] Starting subtest: y-tiled-to-vebox-linear
[590.541456] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[590.733980] [095/133] (430s left) kms_vblank (ts-continuation-suspend)
[590.830708] Starting subtest: ts-continuation-suspend
[590.832929] Starting dynamic subtest: pipe-A-eDP-1
[607.387647] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.492s)
[607.405080] Starting dynamic subtest: pipe-D-eDP-1
[624.388172] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s)
[624.390407] Subtest ts-continuation-suspend: SUCCESS (3.651s)
[625.219061] [096/133] (395s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[625.282083] Starting subtest: etime-single-wait-for-submit-unsubmitted
[625.386611] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[625.476257] [097/133] (395s left) dmabuf_sync_file (export-wait-after-attach)
[625.525713] Starting subtest: export-wait-after-attach
[625.527948] Subtest export-wait-after-attach: SUCCESS (0.001s)
[625.588472] [098/133] (395s left) gem_softpin (allocator-evict)
[625.655247] Starting subtest: allocator-evict
[625.657517] Starting dynamic subtest: rcs0
[649.091408] Dynamic subtest rcs0: SUCCESS (23.415s)
[649.105957] Starting dynamic subtest: bcs0
[673.016331] Dynamic subtest bcs0: SUCCESS (23.923s)
[673.030129] Starting dynamic subtest: vcs0
[696.523668] Dynamic subtest vcs0: SUCCESS (23.502s)
[696.538014] Starting dynamic subtest: vcs1
[720.194418] Dynamic subtest vcs1: SUCCESS (23.661s)
[720.214549] Starting dynamic subtest: vecs0
[744.091823] Dynamic subtest vecs0: SUCCESS (23.901s)
[744.105376] Starting dynamic subtest: ccs0
[767.923123] Dynamic subtest ccs0: SUCCESS (23.829s)
[767.925499] Subtest allocator-evict: SUCCESS (142.238s)
[768.009710] [099/133] (253s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[768.156700] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[768.825698] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[768.988792] [100/133] (252s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[769.087073] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[770.191615] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.104s)
[770.303336] [101/133] (251s left) kms_pm_rpm (cursor-dpms)
[771.945269] Starting subtest: cursor-dpms
[771.950085] Subtest cursor-dpms: SKIP (0.000s)
[772.569627] [102/133] (248s left) kms_flip (bo-too-big-interruptible)
[772.679237] Starting subtest: bo-too-big-interruptible
[772.681620] Starting dynamic subtest: A-eDP1
[773.988146] Dynamic subtest A-eDP1: SUCCESS (1.307s)
[774.002572] Starting dynamic subtest: B-eDP1
[775.222945] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[775.234463] Starting dynamic subtest: C-eDP1
[776.466187] Dynamic subtest C-eDP1: SUCCESS (1.241s)
[776.481490] Starting dynamic subtest: D-eDP1
[777.724211] Dynamic subtest D-eDP1: SUCCESS (1.257s)
[777.729819] Subtest bo-too-big-interruptible: SUCCESS (5.050s)
[778.922614] [103/133] (242s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[779.024715] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[779.026934] Starting dynamic subtest: pipe-A-eDP-1
[779.048678] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[779.061096] Starting dynamic subtest: pipe-B-eDP-1
[779.081390] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[779.092424] Starting dynamic subtest: pipe-C-eDP-1
[779.113648] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[779.124004] Starting dynamic subtest: pipe-D-eDP-1
[779.145692] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[779.150087] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[781.286571] [104/133] (240s left) gem_mmap_gtt (big-bo-tiledx)
[781.350455] Subtest big-bo-tiledX: SKIP (0.000s)
[781.415421] [105/133] (240s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[781.516457] Starting subtest: bad-aux-stride-yf-tiled-ccs
[781.518930] Starting dynamic subtest: pipe-A-eDP-1
[781.542900] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[781.556657] Starting dynamic subtest: pipe-B-eDP-1
[781.578639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[781.591730] Starting dynamic subtest: pipe-C-eDP-1
[781.613533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[781.624711] Starting dynamic subtest: pipe-D-eDP-1
[781.646942] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[781.651250] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[783.752495] [106/133] (237s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[784.327358] Starting subtest: syncobj-timeline-invalid-flags
[784.329455] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[785.887364] [107/133] (235s left) kms_cursor_crc (cursor-onscreen-128x128)
[786.107821] Starting subtest: cursor-onscreen-128x128
[786.110120] Starting dynamic subtest: pipe-A-eDP-1
[788.219583] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[788.250473] Starting dynamic subtest: pipe-D-eDP-1
[791.025647] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s)
[791.028048] Subtest cursor-onscreen-128x128: SUCCESS (4.919s)
[791.917285] [108/133] (229s left) vgem_basic (debugfs)
[791.956514] Starting subtest: debugfs
[791.958686] Subtest debugfs: SUCCESS (0.000s)
[792.017235] [109/133] (229s left) kms_atomic_transition (plane-all-transition-fencing)
[792.108134] Starting subtest: plane-all-transition-fencing
[792.110293] Starting dynamic subtest: pipe-A-eDP-1
[794.619528] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.510s)
[794.930480] Starting dynamic subtest: pipe-B-eDP-1
[798.137989] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[798.437157] Subtest plane-all-transition-fencing: SUCCESS (6.325s)
[799.266197] [110/133] (222s left) gem_exec_params (mmapped)
[799.339471] Starting subtest: mmapped
[799.341860] Subtest mmapped: SUCCESS (0.003s)
[799.486983] [111/133] (222s left) kms_content_protection (lic-type-1)
[799.636366] Starting subtest: lic-type-1
[799.640982] Subtest lic-type-1: SKIP (0.000s)
[799.761522] [112/133] (222s left) sw_sync (alloc_timeline)
[799.797828] Starting subtest: alloc_timeline
[799.799982] Subtest alloc_timeline: SUCCESS (0.000s)
[799.872334] [113/133] (222s left) gem_exec_alignment (forked)
[799.942699] Starting subtest: forked
[838.514211] Subtest forked: SUCCESS (38.560s)
[838.597149] [114/133] (183s left) syncobj_wait (invalid-reset-bad-pad)
[838.688528] Starting subtest: invalid-reset-bad-pad
[838.691078] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[838.766822] [115/133] (183s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[838.873375] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[845.900366] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.029s)
[846.025718] [116/133] (176s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[846.130565] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[846.134630] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[846.242330] [117/133] (175s left) kms_chamelium_color (ctm-0-75)
[846.347008] Subtest ctm-0-75: SKIP (0.000s)
[846.393043] [118/133] (175s left) i915_hangman (gt-error-state-capture)
[846.450774] Starting subtest: gt-error-state-capture
[846.453104] Starting dynamic subtest: rcs0
[857.774230] Dynamic subtest rcs0: SUCCESS (11.324s)
[857.789487] Starting dynamic subtest: bcs0
[869.740960] Dynamic subtest bcs0: SUCCESS (11.966s)
[869.756001] Starting dynamic subtest: vcs0
[881.708795] Dynamic subtest vcs0: SUCCESS (11.967s)
[881.723022] Starting dynamic subtest: vcs1
[892.716799] Dynamic subtest vcs1: SUCCESS (11.005s)
[892.731755] Starting dynamic subtest: vecs0
[903.724321] Dynamic subtest vecs0: SUCCESS (11.005s)
[903.742107] Starting dynamic subtest: ccs0
[915.756623] Dynamic subtest ccs0: SUCCESS (12.029s)
[915.759521] Subtest gt-error-state-capture: SUCCESS (69.311s)
[915.839997] [119/133] (106s left) syncobj_timeline (invalid-transfer-bad-pad)
[915.899937] Starting subtest: invalid-transfer-bad-pad
[915.902102] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[916.019611] [120/133] (106s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[916.124065] Starting subtest: fbc-rgb565-draw-render
[920.252509] Subtest fbc-rgb565-draw-render: SUCCESS (4.132s)
[921.402082] [121/133] (100s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[921.502181] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[922.671380] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.168s)
[922.794390] [122/133] ( 99s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[922.903392] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[922.906885] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[922.976328] [123/133] ( 99s left) gem_userptr_blits (sd-probe)
[923.041401] Starting subtest: sd-probe
[923.043236] Subtest sd-probe: SUCCESS (0.000s)
[923.165454] [124/133] ( 99s left) gem_fenced_exec_thrash (too-many-fences)
[923.228384] Subtest too-many-fences: SKIP (0.000s)
[923.296870] [125/133] ( 99s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[923.393631] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[923.397320] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[923.506386] [126/133] ( 99s left) kms_cursor_crc (cursor-random-64x64)
[923.697024] Starting subtest: cursor-random-64x64
[923.701419] Starting dynamic subtest: pipe-A-eDP-1
[927.029804] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.328s)
[927.061938] Starting dynamic subtest: pipe-D-eDP-1
[931.002291] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.951s)
[931.004682] Subtest cursor-random-64x64: SUCCESS (7.304s)
[931.880249] [127/133] ( 90s left) kms_psr (pr-dpms)
[931.973070] Starting subtest: pr-dpms
[931.977397] Subtest pr-dpms: SKIP (0.000s)
[932.046173] [128/133] ( 90s left) kms_flip (flip-vs-blocking-wf-vblank)
[932.138397] Starting subtest: flip-vs-blocking-wf-vblank
[932.140670] Starting dynamic subtest: A-eDP1
[941.026759] Dynamic subtest A-eDP1: SUCCESS (8.887s)
[941.040543] Starting dynamic subtest: B-eDP1
[949.962244] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[949.973672] Starting dynamic subtest: C-eDP1
[958.882610] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[958.897132] Starting dynamic subtest: D-eDP1
[967.810704] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[967.813130] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.670s)
[969.055823] [129/133] ( 53s left) gem_exec_params (no-blt)
[969.120415] Starting subtest: no-blt
[969.125743] Subtest no-blt: SUCCESS (0.003s)
[969.263331] [130/133] ( 53s left) gem_exec_balancer (bonded-semaphore)
[969.320728] Starting subtest: bonded-semaphore
[969.325310] Subtest bonded-semaphore: SKIP (0.000s)
[969.611977] [131/133] ( 53s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[970.002799] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[970.848052] [132/133] ( 51s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[970.943988] Starting subtest: bad-pixel-format-y-tiled-ccs
[970.946267] Starting dynamic subtest: pipe-A-eDP-1
[970.968807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[970.981579] Starting dynamic subtest: pipe-B-eDP-1
[971.002926] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[971.013658] Starting dynamic subtest: pipe-C-eDP-1
[971.035220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[971.046110] Starting dynamic subtest: pipe-D-eDP-1
[971.067935] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[971.072222] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[973.236849] [133/133] ( 49s left) gem_exec_flush (basic-wb-set-default)
[973.308555] Starting subtest: basic-wb-set-default
[978.760289] Subtest basic-wb-set-default: SUCCESS (5.451s)
[978.959446] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_mmap_write_crc
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_dirtyfb
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_invalid_mode
results: parsing output: 24/ for test: gem_exec_capture
results: parsing output: 25/ for test: sysfs_timeslice_duration
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_multipipe_modeset
results: parsing output: 28/ for test: kms_draw_crc
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: gem_ctx_exec
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_chamelium_color
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_sequence
results: parsing output: 45/ for test: gem_ctx_bad_destroy
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_basic
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: gem_ccs
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: gem_exec_await
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_pm_rps
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_properties
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_pipe_b_c_ivb
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: gem_close
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: kms_getfb
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_hdr
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: kms_atomic_transition
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_content_protection
results: parsing output: 111/ for test: sw_sync
results: parsing output: 112/ for test: gem_exec_alignment
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_chamelium_color
results: parsing output: 117/ for test: i915_hangman
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: gem_fenced_exec_thrash
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_exec_flush
Done.