[56.883176] Initializing watchdogs
[56.883223]   /dev/watchdog0
[56.898519] [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.902938] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.905320] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.908877] [001/131] (960s left) gem_basic (create-close)
[56.991952] Starting subtest: create-close
[56.996641] Subtest create-close: SUCCESS (0.000s)
[57.088754] [002/131] (960s left) gem_eio (wait-immediate)
[57.234466] Starting subtest: wait-immediate
[57.466966] Subtest wait-immediate: SUCCESS (0.235s)
[57.640967] [003/131] (959s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[58.032075] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[58.814655] [004/131] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[58.908660] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[65.748306] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.873s)
[65.900176] [005/131] (951s left) kms_sequence (queue-idle)
[65.994052] Starting subtest: queue-idle
[65.996479] Starting dynamic subtest: pipe-A-eDP-1
[67.795916] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s)
[67.804465] Starting dynamic subtest: pipe-B-eDP-1
[70.317673] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.526s)
[70.327125] Starting dynamic subtest: pipe-C-eDP-1
[72.812836] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.498s)
[72.822315] Starting dynamic subtest: pipe-D-eDP-1
[75.249350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[75.251364] Subtest queue-idle: SUCCESS (9.269s)
[76.071590] [006/131] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[76.184358] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[76.188494] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[76.283705] [007/131] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[76.386047] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[76.390356] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[76.486566] [008/131] (941s left) kms_async_flips (async-flip-hang)
[76.588615] Starting subtest: async-flip-hang
[76.960333] Starting dynamic subtest: pipe-A-eDP-1
[79.889079] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.926s)
[80.266382] Starting dynamic subtest: pipe-B-eDP-1
[83.418636] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.157s)
[83.790544] Starting dynamic subtest: pipe-C-eDP-1
[86.978809] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.195s)
[87.371239] Starting dynamic subtest: pipe-D-eDP-1
[90.479688] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[90.482068] Subtest async-flip-hang: SUCCESS (13.894s)
[91.726647] [009/131] (926s left) gem_workarounds (reset)
[91.818140] Starting subtest: reset
[91.918584] Subtest reset: SUCCESS (0.103s)
[92.043752] [010/131] (925s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[92.144237] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[92.148695] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[92.213026] [011/131] (925s left) gem_create (create-ext-set-pat)
[92.379326] Starting subtest: create-ext-set-pat
[92.381792] Subtest create-ext-set-pat: SUCCESS (0.001s)
[92.487563] [012/131] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[92.585232] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[92.589521] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[92.682600] [013/131] (925s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[92.788456] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[92.792865] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[92.858882] [014/131] (925s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[92.944198] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[92.947708] Starting dynamic subtest: pipe-A-eDP-1
[92.956554] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[92.969520] Starting dynamic subtest: pipe-B-eDP-1
[92.978514] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[92.986457] Starting dynamic subtest: pipe-C-eDP-1
[92.994801] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.002978] Starting dynamic subtest: pipe-D-eDP-1
[93.011933] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.016237] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[95.104527] [015/131] (922s left) gem_exec_nop (basic-parallel)
[95.180144] Starting subtest: basic-parallel
[110.871756] Subtest basic-parallel: SUCCESS (15.700s)
[111.113543] [016/131] (906s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[111.211225] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[115.661920] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.454s)
[116.803201] [017/131] (901s left) kms_psr (fbc-psr2-dpms)
[116.896023] Starting subtest: fbc-psr2-dpms
[116.898334] Starting dynamic subtest: eDP-1
[116.902486] Dynamic subtest eDP-1: SKIP (0.000s)
[116.906645] Subtest fbc-psr2-dpms: SKIP (0.001s)
[116.965304] [018/131] (901s left) gem_linear_blits (basic)
[117.329608] Starting subtest: basic
[117.340559] Subtest basic: SUCCESS (0.012s)
[117.464855] [019/131] (900s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[117.600270] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[117.602633] Starting dynamic subtest: pipe-A
[117.624991] Dynamic subtest pipe-A: SKIP (0.019s)
[117.638726] Starting dynamic subtest: pipe-B
[117.656093] Dynamic subtest pipe-B: SKIP (0.031s)
[117.664533] Starting dynamic subtest: pipe-C
[117.686606] Dynamic subtest pipe-C: SKIP (0.031s)
[117.694610] Starting dynamic subtest: pipe-D
[117.717313] Dynamic subtest pipe-D: SKIP (0.031s)
[117.721525] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.113s)
[117.836397] [020/131] (900s left) gem_userptr_blits (create-destroy-sync)
[117.907518] Starting subtest: create-destroy-sync
[122.919716] Subtest create-destroy-sync: SUCCESS (5.011s)
[123.035041] [021/131] (895s left) kms_psr (fbc-psr-suspend)
[123.136847] Starting subtest: fbc-psr-suspend
[123.139050] Starting dynamic subtest: eDP-1
[123.143401] Dynamic subtest eDP-1: SKIP (0.000s)
[123.147758] Subtest fbc-psr-suspend: SKIP (0.001s)
[123.218211] [022/131] (895s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[123.273938] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[123.276076] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[123.369185] [023/131] (894s left) gem_ccs (ctrl-surf-copy-new-ctx)
[123.423053] Starting subtest: ctrl-surf-copy-new-ctx
[123.427617] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[123.519401] [024/131] (894s left) kms_chamelium_color (gamma)
[123.614469] Subtest gamma: SKIP (0.000s)
[123.656996] [025/131] (894s left) gem_lmem_swapping (massive)
[123.704841] Subtest massive: SKIP (0.000s)
[123.745618] [026/131] (894s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[123.840378] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[123.844560] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[123.930932] [027/131] (894s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[124.025922] Starting subtest: y-tiled-addfb-size-offset-overflow
[124.029470] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[124.127289] [028/131] (894s left) gem_exec_fence (syncobj-channel)
[124.563986] Starting subtest: syncobj-channel
[125.582709] Subtest syncobj-channel: SUCCESS (1.016s)
[125.956966] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[125.960249] [029/131] (892s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[126.306468] Starting subtest: cursor-rapid-movement-max-size
[126.313787] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[126.432702] [030/131] (892s left) kms_chamelium_color (ctm-0-25)
[126.534764] Subtest ctm-0-25: SKIP (0.000s)
[126.579509] [031/131] (892s left) gem_sync (basic-store-each)
[126.655136] Starting subtest: basic-store-each
[128.997397] Subtest basic-store-each: SUCCESS (2.353s)
[129.179798] [032/131] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[129.283267] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[129.287301] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[129.396166] [033/131] (889s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[129.495203] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[130.185396] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[130.350270] [034/131] (888s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[130.437768] Starting subtest: psr-dirtyfb-ioctl
[130.439677] Starting dynamic subtest: A-eDP-1
[134.401909] Dynamic subtest A-eDP-1: SUCCESS (3.964s)
[134.404258] Subtest psr-dirtyfb-ioctl: SUCCESS (3.965s)
[135.274578] [035/131] (883s left) perf_pmu (event-wait)
[135.317614] Starting subtest: event-wait
[135.319805] Starting dynamic subtest: rcs0
[135.324112] Dynamic subtest rcs0: SKIP (0.000s)
[135.328080] Subtest event-wait: SKIP (0.000s)
[135.417520] [036/131] (883s left) sysfs_heartbeat_interval (idempotent)
[135.487144] Starting subtest: idempotent
[135.489540] Starting dynamic subtest: vecs0
[135.491765] Dynamic subtest vecs0: SUCCESS (0.001s)
[135.501374] Starting dynamic subtest: ccs0
[135.503614] Dynamic subtest ccs0: SUCCESS (0.001s)
[135.511626] Starting dynamic subtest: vcs0
[135.513788] Dynamic subtest vcs0: SUCCESS (0.000s)
[135.521761] Starting dynamic subtest: bcs0
[135.523908] Dynamic subtest bcs0: SUCCESS (0.001s)
[135.531659] Starting dynamic subtest: rcs0
[135.533780] Dynamic subtest rcs0: SUCCESS (0.000s)
[135.541605] Starting dynamic subtest: vcs1
[135.543454] Dynamic subtest vcs1: SUCCESS (0.000s)
[135.545693] Subtest idempotent: SUCCESS (0.006s)
[135.603325] [037/131] (883s left) perf (whitelisted-registers-userspace-config)
[135.736158] Starting subtest: whitelisted-registers-userspace-config
[135.738311] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[135.783150] [038/131] (883s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[135.881118] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[135.883358] Starting dynamic subtest: pipe-A
[136.264764] Dynamic subtest pipe-A: SUCCESS (0.386s)
[136.278172] Starting dynamic subtest: pipe-B
[137.677262] Dynamic subtest pipe-B: SUCCESS (1.411s)
[137.686500] Starting dynamic subtest: pipe-C
[139.127876] Dynamic subtest pipe-C: SUCCESS (1.450s)
[139.141940] Starting dynamic subtest: pipe-D
[140.547904] Dynamic subtest pipe-D: SUCCESS (1.419s)
[140.550248] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.671s)
[141.700780] [039/131] (877s left) gem_softpin (evict-prime)
[141.766612] Starting subtest: evict-prime
[141.769040] Starting dynamic subtest: rcs0
[142.918536] Dynamic subtest rcs0: SUCCESS (1.152s)
[142.927828] Starting dynamic subtest: bcs0
[144.047704] Dynamic subtest bcs0: SUCCESS (1.128s)
[144.057782] Starting dynamic subtest: vcs0
[145.880409] Dynamic subtest vcs0: SUCCESS (1.830s)
[145.891727] Starting dynamic subtest: vcs1
[147.865713] Dynamic subtest vcs1: SUCCESS (1.983s)
[147.879627] Starting dynamic subtest: vecs0
[149.913051] Dynamic subtest vecs0: SUCCESS (2.047s)
[149.927543] Starting dynamic subtest: ccs0
[151.039795] Dynamic subtest ccs0: SUCCESS (1.126s)
[151.051411] Starting dynamic subtest: all
[152.867837] Dynamic subtest all: SUCCESS (1.825s)
[152.870666] Subtest evict-prime: SUCCESS (11.100s)
[152.947356] [040/131] (866s left) gem_ctx_param (basic)
[152.996815] Starting subtest: basic
[152.999266] Subtest basic: SUCCESS (0.001s)
[153.116054] [041/131] (865s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[153.174503] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[153.240961] [042/131] (865s left) perf_pmu (busy-accuracy-50)
[153.294337] Starting subtest: busy-accuracy-50
[153.296518] Starting dynamic subtest: rcs0
[154.837530] Dynamic subtest rcs0: SUCCESS (1.542s)
[154.847940] Starting dynamic subtest: bcs0
[156.382167] Dynamic subtest bcs0: SUCCESS (1.543s)
[156.394884] Starting dynamic subtest: vcs0
[157.925953] Dynamic subtest vcs0: SUCCESS (1.542s)
[157.938130] Starting dynamic subtest: vcs1
[159.468248] Dynamic subtest vcs1: SUCCESS (1.540s)
[159.479669] Starting dynamic subtest: vecs0
[161.008874] Dynamic subtest vecs0: SUCCESS (1.539s)
[161.020390] Starting dynamic subtest: ccs0
[162.554741] Dynamic subtest ccs0: SUCCESS (1.544s)
[162.557228] Subtest busy-accuracy-50: SUCCESS (9.260s)
[162.671415] [043/131] (856s left) gem_ctx_persistence (heartbeat-hostile)
[162.726974] Starting subtest: heartbeat-hostile
[162.731787] Subtest heartbeat-hostile: SKIP (0.000s)
[162.834265] [044/131] (856s left) gem_mmap_gtt (basic-read-write)
[162.885442] Subtest basic-read-write: SKIP (0.000s)
[162.945600] [045/131] (856s left) api_intel_bb (blit-reloc-keep-cache)
[163.000430] Starting subtest: blit-reloc-keep-cache
[163.004946] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[163.115968] [046/131] (856s left) i915_pm_rc6_residency (rc6-accuracy)
[163.168911] Starting subtest: rc6-accuracy
[163.171126] Starting dynamic subtest: gt0
[166.341295] Dynamic subtest gt0: SUCCESS (3.169s)
[166.352975] Starting dynamic subtest: gt1
[169.512384] Dynamic subtest gt1: SUCCESS (3.169s)
[169.515314] Subtest rc6-accuracy: SUCCESS (6.342s)
[169.584684] [047/131] (849s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[169.647530] Starting subtest: etime-multi-wait-all-available-unsubmitted
[169.755983] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[169.832229] [048/131] (849s left) gem_render_copy (y-tiled-to-vebox-linear)
[169.904185] Starting subtest: y-tiled-to-vebox-linear
[169.909400] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[170.093589] [049/131] (849s left) gem_mmap_gtt (close-race)
[170.161038] Subtest close-race: SKIP (0.000s)
[170.227712] [050/131] (849s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[170.325180] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[170.329618] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[170.398025] [051/131] (849s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[170.501785] Starting subtest: x-tiled-64bpp-rotate-270
[170.521852] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[170.636211] [052/131] (848s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[170.697472] Starting subtest: y-tiled-ccs-to-y-tiled
[170.702140] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[170.882839] [053/131] (848s left) kms_cursor_crc (cursor-onscreen-256x256)
[171.144943] Starting subtest: cursor-onscreen-256x256
[171.150284] Starting dynamic subtest: pipe-A-eDP-1
[173.261712] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[173.288187] Starting dynamic subtest: pipe-D-eDP-1
[176.059239] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[176.061689] Subtest cursor-onscreen-256x256: SUCCESS (4.913s)
[176.873152] [054/131] (842s left) gem_exec_balancer (bonded-true-hang)
[177.129066] Starting subtest: bonded-true-hang
[177.135066] Subtest bonded-true-hang: SKIP (0.000s)
[177.241987] [055/131] (842s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[177.302850] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[177.304986] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[177.393351] [056/131] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[177.509483] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[184.068977] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.564s)
[184.174982] [057/131] (835s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[184.302432] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[184.306946] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[184.397488] [058/131] (835s left) gem_exec_schedule (timeslicing)
[184.475330] Starting subtest: timeslicing
[184.477793] Starting dynamic subtest: rcs0
[184.484735] Dynamic subtest rcs0: SUCCESS (0.020s)
[184.493594] Starting dynamic subtest: bcs0
[184.506478] Dynamic subtest bcs0: SUCCESS (0.021s)
[184.515223] Starting dynamic subtest: vcs0
[184.529161] Dynamic subtest vcs0: SUCCESS (0.021s)
[184.538088] Starting dynamic subtest: vcs1
[184.549803] Dynamic subtest vcs1: SUCCESS (0.020s)
[184.558712] Starting dynamic subtest: vecs0
[184.570444] Dynamic subtest vecs0: SUCCESS (0.020s)
[184.579364] Starting dynamic subtest: ccs0
[184.591246] Dynamic subtest ccs0: SUCCESS (0.020s)
[184.593617] Subtest timeslicing: SUCCESS (0.128s)
[185.994054] [059/131] (833s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[186.048562] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[186.120963] [060/131] (833s left) api_intel_bb (render)
[186.174831] Starting subtest: render
[186.176738] Starting dynamic subtest: render-none-512
[186.274057] Dynamic subtest render-none-512: SUCCESS (0.101s)
[186.285666] Starting dynamic subtest: render-none-1024
[186.656721] Dynamic subtest render-none-1024: SUCCESS (0.380s)
[186.667983] Starting dynamic subtest: render-x-512
[186.741931] Dynamic subtest render-x-512: SUCCESS (0.085s)
[186.753031] Starting dynamic subtest: render-x-1024
[187.092279] Dynamic subtest render-x-1024: SUCCESS (0.348s)
[187.104240] Starting dynamic subtest: render-y-512
[187.182321] Dynamic subtest render-y-512: SUCCESS (0.091s)
[187.193994] Starting dynamic subtest: render-y-1024
[187.534251] Dynamic subtest render-y-1024: SUCCESS (0.350s)
[187.537325] Subtest render: SUCCESS (1.360s)
[187.617071] [061/131] (832s left) kms_draw_crc (draw-method-blt)
[187.719369] Starting subtest: draw-method-blt
[187.721695] Starting dynamic subtest: xrgb8888-untiled
[187.972800] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[187.982822] Starting dynamic subtest: rgb565-untiled
[188.217252] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[188.227186] Starting dynamic subtest: xrgb2101010-untiled
[188.439441] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[188.448891] Starting dynamic subtest: xbgr16161616f-untiled
[188.661263] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[188.670452] Starting dynamic subtest: xrgb8888-xtiled
[188.772671] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[188.782554] Starting dynamic subtest: rgb565-xtiled
[188.894558] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[188.903362] Starting dynamic subtest: xrgb2101010-xtiled
[189.005906] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[189.014378] Starting dynamic subtest: xbgr16161616f-xtiled
[189.116848] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[189.125741] Starting dynamic subtest: xrgb8888-4tiled
[189.227974] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[189.239865] Starting dynamic subtest: rgb565-4tiled
[189.350096] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[189.358782] Starting dynamic subtest: xrgb2101010-4tiled
[189.461064] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[189.469838] Starting dynamic subtest: xbgr16161616f-4tiled
[189.572433] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[189.574353] Subtest draw-method-blt: SUCCESS (1.856s)
[189.686479] [062/131] (830s left) gem_exec_whisper (basic-fds-all)
[189.742500] Starting subtest: basic-fds-all
[200.865281] Subtest basic-fds-all: SUCCESS (11.119s)
[201.071904] [063/131] (818s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[201.171341] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[201.200056] Starting dynamic subtest: pipe-A-plane-0
[201.644572] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[201.653751] Starting dynamic subtest: pipe-A-plane-3
[201.899430] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[203.004720] Starting dynamic subtest: pipe-B-plane-0
[203.474692] Dynamic subtest pipe-B-plane-0: SUCCESS (0.477s)
[203.483966] Starting dynamic subtest: pipe-B-plane-3
[203.741536] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[204.061859] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.888s)
[204.892167] [064/131] (815s left) kms_psr (fbc-psr-primary-page-flip)
[204.975141] Starting subtest: fbc-psr-primary-page-flip
[204.977393] Starting dynamic subtest: eDP-1
[204.981702] Dynamic subtest eDP-1: SKIP (0.000s)
[204.985903] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[205.048230] [065/131] (815s left) gem_exec_params (sol-reset-invalid)
[205.102071] Starting subtest: sol-reset-invalid
[205.104165] Subtest sol-reset-invalid: SUCCESS (0.002s)
[206.983778] [066/131] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[207.078641] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[213.889387] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.814s)
[214.025888] [067/131] (806s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[214.119763] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[214.124161] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[214.220464] [068/131] (805s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[214.352869] Starting subtest: dp-mst-type-0-suspend-resume
[214.357305] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[214.488298] [069/131] (805s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[214.578171] Starting subtest: coverage-vs-premult-vs-constant
[214.865249] Starting dynamic subtest: pipe-A-eDP-1
[215.471844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[215.480745] Starting dynamic subtest: pipe-D-eDP-1
[216.804121] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[216.806295] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.226s)
[217.669777] [070/131] (802s left) perf (non-sampling-read-error)
[217.761616] Starting subtest: non-sampling-read-error
[217.773679] Subtest non-sampling-read-error: SUCCESS (0.009s)
[217.817819] [071/131] (802s left) kms_big_fb (linear-8bpp-rotate-180)
[217.926673] Starting subtest: linear-8bpp-rotate-180
[219.173747] Subtest linear-8bpp-rotate-180: SUCCESS (1.247s)
[219.285495] [072/131] (801s left) gem_pxp (hw-rejects-pxp-buffer)
[219.406079] Starting subtest: hw-rejects-pxp-buffer
[219.409891] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[219.533995] [073/131] (800s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[219.588207] Starting subtest: invalid-single-wait-all-unsubmitted
[219.590191] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[219.669668] [074/131] (800s left) gem_ctx_param (invalid-get-ringsize)
[219.714192] Starting subtest: invalid-get-ringsize
[219.716252] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[219.805373] [075/131] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[219.902402] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[219.905742] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.997590] [076/131] (800s left) drm_read (empty-block)
[220.137316] Starting subtest: empty-block
[221.135384] Subtest empty-block: SUCCESS (1.000s)
[221.260291] [077/131] (799s left) kms_cursor_edge_walk (64x64-top-bottom)
[221.353941] Starting subtest: 64x64-top-bottom
[221.356585] Starting dynamic subtest: pipe-A-eDP-1
[224.823057] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[224.833047] Starting dynamic subtest: pipe-D-eDP-1
[227.952474] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[227.954720] Subtest 64x64-top-bottom: SUCCESS (6.600s)
[228.751713] [078/131] (791s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[228.862746] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[228.865057] Starting dynamic subtest: A-eDP1
[232.480098] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[232.489916] Starting dynamic subtest: B-eDP1
[235.749966] Dynamic subtest B-eDP1: SUCCESS (3.266s)
[235.760091] Starting dynamic subtest: C-eDP1
[238.875149] Dynamic subtest C-eDP1: SUCCESS (3.125s)
[238.885881] Starting dynamic subtest: D-eDP1
[241.960555] Dynamic subtest D-eDP1: SUCCESS (3.084s)
[241.965499] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.102s)
[242.754450] [079/131] (777s left) kms_pm_rpm (drm-resources-equal)
[245.086673] Starting subtest: drm-resources-equal
[250.112017] Subtest drm-resources-equal: SUCCESS (5.028s)
[250.204524] [080/131] (770s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[250.288053] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[250.290272] Starting dynamic subtest: pipe-A-eDP-1
[250.299278] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.310640] Starting dynamic subtest: pipe-B-eDP-1
[250.319254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.328939] Starting dynamic subtest: pipe-C-eDP-1
[250.337568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.346582] Starting dynamic subtest: pipe-D-eDP-1
[250.355089] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.359182] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[252.595863] [081/131] (768s left) gem_exec_schedule (preemptive-hang)
[252.773244] Starting subtest: preemptive-hang
[252.775365] Starting dynamic subtest: rcs0
[262.017260] Dynamic subtest rcs0: SUCCESS (9.246s)
[262.028397] Starting dynamic subtest: bcs0
[271.041175] Dynamic subtest bcs0: SUCCESS (9.021s)
[271.056904] Starting dynamic subtest: vcs0
[279.996960] Dynamic subtest vcs0: SUCCESS (8.955s)
[280.008584] Starting dynamic subtest: vcs1
[289.020605] Dynamic subtest vcs1: SUCCESS (9.021s)
[289.032712] Starting dynamic subtest: vecs0
[298.048109] Dynamic subtest vecs0: SUCCESS (9.026s)
[298.059561] Starting dynamic subtest: ccs0
[307.069769] Dynamic subtest ccs0: SUCCESS (9.020s)
[307.072180] Subtest preemptive-hang: SUCCESS (54.300s)
[307.322548] [082/131] (713s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[307.434230] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[307.438846] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[307.526030] [083/131] (713s left) gen7_exec_parse (bitmasks)
[307.603019] Subtest bitmasks: SKIP (0.000s)
[307.663063] [084/131] (713s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[307.752872] Starting subtest: bad-aux-stride-yf-tiled-ccs
[307.755134] Starting dynamic subtest: pipe-A-eDP-1
[307.776972] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.786855] Starting dynamic subtest: pipe-B-eDP-1
[307.808422] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.817696] Starting dynamic subtest: pipe-C-eDP-1
[307.839173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.850571] Starting dynamic subtest: pipe-D-eDP-1
[307.873234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.877285] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[310.065146] [085/131] (710s left) gem_mmap_offset (close-race)
[310.115120] Starting subtest: close-race
[330.241025] Subtest close-race: SUCCESS (20.125s)
[330.371499] [086/131] (690s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[330.479898] Starting subtest: primary-4-tiled-reflect-x-180
[337.442993] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.964s)
[338.624153] [087/131] (682s left) kms_properties (crtc-properties-legacy)
[338.716108] Starting subtest: crtc-properties-legacy
[338.718304] Starting dynamic subtest: pipe-A-eDP-1
[339.153072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[339.162735] Starting dynamic subtest: pipe-B-eDP-1
[340.294270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[340.303671] Starting dynamic subtest: pipe-C-eDP-1
[341.423246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[341.433295] Starting dynamic subtest: pipe-D-eDP-1
[342.585516] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[342.587913] Subtest crtc-properties-legacy: SUCCESS (3.870s)
[343.386833] [088/131] (677s left) kms_psr (psr2-primary-mmap-gtt)
[343.479311] Starting subtest: psr2-primary-mmap-gtt
[343.481501] Starting dynamic subtest: eDP-1
[344.876834] Dynamic subtest eDP-1: SKIP (1.394s)
[344.881745] Subtest psr2-primary-mmap-gtt: SKIP (1.396s)
[344.996745] [089/131] (676s left) kms_invalid_mode (bad-vsync-start)
[345.091134] Starting subtest: bad-vsync-start
[345.093297] Starting dynamic subtest: pipe-A-eDP-1
[345.378577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[345.390833] Starting dynamic subtest: pipe-B-eDP-1
[345.392904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[345.401882] Starting dynamic subtest: pipe-C-eDP-1
[345.404152] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[345.412973] Starting dynamic subtest: pipe-D-eDP-1
[345.415173] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[345.417445] Subtest bad-vsync-start: SUCCESS (0.290s)
[346.249895] [090/131] (674s left) kms_atomic_transition (plane-all-transition-fencing)
[346.335019] Starting subtest: plane-all-transition-fencing
[346.337329] Starting dynamic subtest: pipe-A-eDP-1
[348.828714] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[349.138848] Starting dynamic subtest: pipe-B-eDP-1
[352.393326] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.264s)
[352.691291] Subtest plane-all-transition-fencing: SUCCESS (6.355s)
[353.507704] [091/131] (667s left) gem_exec_reloc (basic-gtt-read-active)
[353.578121] Subtest basic-gtt-read-active: SKIP (0.000s)
[353.651566] [092/131] (667s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[353.756149] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[353.760748] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[354.837543] [093/131] (666s left) kms_lease (lease-uevent)
[354.945290] Starting subtest: lease-uevent
[355.959048] Subtest lease-uevent: SUCCESS (1.016s)
[356.063303] [094/131] (665s left) gen3_render_tiledx_blits
[356.206532] [095/131] (665s left) gem_exec_params (invalid-fence-in-submit)
[356.276858] Starting subtest: invalid-fence-in-submit
[356.282029] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[356.419543] [096/131] (664s left) dmabuf (all-tests)
[356.466516] Starting subtest: all-tests
[356.468775] Starting dynamic subtest: sanitycheck
[356.624283] Dynamic subtest sanitycheck: SUCCESS (0.159s)
[356.635633] Starting dynamic subtest: dma_fence
[356.856583] Dynamic subtest dma_fence: SUCCESS (0.232s)
[356.869574] Starting dynamic subtest: dma_fence_chain
[366.162162] Dynamic subtest dma_fence_chain: SUCCESS (9.301s)
[366.176288] Starting dynamic subtest: dma_fence_unwrap
[366.242641] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s)
[366.256977] Starting dynamic subtest: dma_resv
[366.337787] Dynamic subtest dma_resv: SUCCESS (0.092s)
[366.340832] Subtest all-tests: SUCCESS (9.875s)
[366.429898] [097/131] (655s left) gem_pwrite (basic-self)
[366.488255] Subtest basic-self: SKIP (0.000s)
[366.557462] [098/131] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[366.676480] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[366.680993] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[366.783139] [099/131] (654s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[366.896432] Starting subtest: plane-lut1d-ctm3x4-lut1d
[367.066196] Starting dynamic subtest: pipe-A-plane-0
[367.390045] Dynamic subtest pipe-A-plane-0: FAIL (0.179s)
[367.399993] Starting dynamic subtest: pipe-A-plane-1
[367.612222] Dynamic subtest pipe-A-plane-1: FAIL (0.173s)
[367.623267] Starting dynamic subtest: pipe-A-plane-2
[367.839113] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[368.836186] Starting dynamic subtest: pipe-B-plane-0
[369.280478] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[369.291624] Starting dynamic subtest: pipe-B-plane-1
[369.611521] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[369.622527] Starting dynamic subtest: pipe-B-plane-2
[369.931837] Dynamic subtest pipe-B-plane-2: FAIL (0.618s)
[370.965145] Starting dynamic subtest: pipe-C-plane-0
[371.481260] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[371.492662] Starting dynamic subtest: pipe-C-plane-1
[371.891558] Dynamic subtest pipe-C-plane-1: FAIL (0.612s)
[371.902636] Starting dynamic subtest: pipe-C-plane-2
[372.282341] Dynamic subtest pipe-C-plane-2: FAIL (0.176s)
[373.107109] Starting dynamic subtest: pipe-D-plane-0
[373.722119] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[373.733807] Starting dynamic subtest: pipe-D-plane-1
[374.199747] Dynamic subtest pipe-D-plane-1: FAIL (0.627s)
[374.210871] Starting dynamic subtest: pipe-D-plane-2
[374.652080] Dynamic subtest pipe-D-plane-2: FAIL (0.554s)
[374.735130] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.839s)
[375.577227] [100/131] (646s left) kms_vblank (wait-forked)
[375.681276] Starting subtest: wait-forked
[375.683120] Starting dynamic subtest: pipe-A-eDP-1
[377.502069] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[377.517158] Starting dynamic subtest: pipe-D-eDP-1
[379.973448] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.470s)
[379.975789] Subtest wait-forked: SUCCESS (4.293s)
[380.844922] [101/131] (640s left) syncobj_timeline (wait-all-for-submit-complex)
[380.899752] Starting subtest: wait-all-for-submit-complex
[381.112627] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[381.189166] [102/131] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[381.283308] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[388.591980] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.311s)
[388.708339] [103/131] (633s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[388.813357] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[389.626743] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[389.789572] [104/131] (631s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[389.853381] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[389.915499] [105/131] (631s left) kms_flip (flip-vs-blocking-wf-vblank)
[390.011240] Starting subtest: flip-vs-blocking-wf-vblank
[390.013549] Starting dynamic subtest: A-eDP1
[398.934240] Dynamic subtest A-eDP1: SUCCESS (8.925s)
[398.946089] Starting dynamic subtest: B-eDP1
[407.870993] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[407.882498] Starting dynamic subtest: C-eDP1
[416.796461] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[416.806173] Starting dynamic subtest: D-eDP1
[425.730068] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[425.735427] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.726s)
[426.962854] [106/131] (594s left) gem_userptr_blits (process-exit)
[427.043866] Starting subtest: process-exit
[427.052048] Subtest process-exit: SUCCESS (0.009s)
[427.171480] [107/131] (594s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[427.284775] Starting subtest: 4-tiled-16bpp-rotate-0
[428.653075] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[428.777463] [108/131] (593s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[428.896416] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[428.900286] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[429.040206] [109/131] (592s left) perf_pmu (frequency)
[429.078798] Starting subtest: frequency
[429.083458] Starting dynamic subtest: gt0
[431.246200] Dynamic subtest gt0: SUCCESS (2.160s)
[431.258140] Starting dynamic subtest: idle-gt0
[431.754165] Dynamic subtest idle-gt0: SUCCESS (0.506s)
[431.765694] Starting dynamic subtest: gt1
[435.904126] Dynamic subtest gt1: SUCCESS (4.145s)
[435.915332] Starting dynamic subtest: idle-gt1
[436.431039] Dynamic subtest idle-gt1: SUCCESS (0.526s)
[436.433823] Subtest frequency: SUCCESS (7.355s)
[436.528949] [110/131] (585s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[436.639105] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[442.986890] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.350s)
[444.141508] [111/131] (577s left) kms_flip (2x-flip-vs-panning)
[444.238666] Starting subtest: 2x-flip-vs-panning
[444.246982] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[444.339216] [112/131] (577s left) kms_psr2_su (frontbuffer-xrgb8888)
[444.394708] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[444.455203] [113/131] (577s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[444.550836] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[444.555284] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[444.618728] [114/131] (577s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[444.717875] Starting subtest: psr-rgb101010-draw-mmap-cpu
[451.942768] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.228s)
[452.044784] [115/131] (570s left) gem_exec_balancer (sequential)
[452.115123] Starting subtest: sequential
[455.249019] Subtest sequential: SUCCESS (3.136s)
[455.561688] [116/131] (566s left) gem_vm_create (execbuf)
[455.622838] Starting subtest: execbuf
[455.633219] Subtest execbuf: SUCCESS (0.013s)
[455.762637] [117/131] (566s left) i915_suspend (debugfs-reader)
[455.822420] Starting subtest: debugfs-reader
[475.046109] Subtest debugfs-reader: SUCCESS (3.664s)
[484.146225] [118/131] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[484.283309] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[484.287101] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[484.378079] [119/131] (547s left) kms_flip (2x-plain-flip-fb-recreate)
[484.458452] Starting subtest: 2x-plain-flip-fb-recreate
[484.470247] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[484.551426] [120/131] (546s left) gem_workarounds (suspend-resume-fd)
[484.624192] Starting subtest: suspend-resume-fd
[501.051358] Subtest suspend-resume-fd: SUCCESS (1.605s)
[513.208034] [121/131] (530s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[513.329950] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[513.334340] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[513.417003] [122/131] (530s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[513.480159] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[513.588046] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[513.673843] [123/131] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[513.765972] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[513.770347] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[513.857561] [124/131] (529s left) kms_prime (basic-crc-vgem)
[513.947278] Starting subtest: basic-crc-vgem
[513.949516] Starting dynamic subtest: second-to-first
[514.891649] Dynamic subtest second-to-first: SUCCESS (0.955s)
[514.893527] Subtest basic-crc-vgem: SUCCESS (0.956s)
[515.001305] [125/131] (528s left) gem_mmap_wc (copy)
[515.081488] Subtest copy: SKIP (0.000s)
[515.140738] [126/131] (528s left) sriov_basic (enable-vfs-bind-unbind-each)
[515.194619] Starting subtest: enable-vfs-bind-unbind-each
[515.196643] Starting dynamic subtest: numvfs-1
[515.257260] Dynamic subtest numvfs-1: FAIL (0.005s)
[515.271336] Starting dynamic subtest: numvfs-2
[515.333317] Dynamic subtest numvfs-2: FAIL (0.004s)
[515.345398] Starting dynamic subtest: numvfs-3
[515.405017] Dynamic subtest numvfs-3: FAIL (0.004s)
[515.415690] Starting dynamic subtest: numvfs-4
[515.478221] Dynamic subtest numvfs-4: FAIL (0.004s)
[515.489812] Starting dynamic subtest: numvfs-5
[515.548610] Dynamic subtest numvfs-5: FAIL (0.004s)
[515.559988] Starting dynamic subtest: numvfs-6
[515.619429] Dynamic subtest numvfs-6: FAIL (0.004s)
[515.630059] Starting dynamic subtest: numvfs-7
[515.691172] Dynamic subtest numvfs-7: FAIL (0.004s)
[515.704895] Starting dynamic subtest: numvfs-random
[515.763148] Dynamic subtest numvfs-random: FAIL (0.004s)
[515.765116] Subtest enable-vfs-bind-unbind-each: FAIL (0.036s)
[515.804088] [127/131] (528s left) i915_drm_fdinfo (virtual-busy-hang)
[515.842257] Starting subtest: virtual-busy-hang
[515.845650] Subtest virtual-busy-hang: SKIP (0.000s)
[515.914620] [128/131] (527s left) prime_mmap_coherency (write)
[515.978799] Starting subtest: write
[521.334773] Subtest write: SUCCESS (5.379s)
[521.469851] [129/131] (522s left) gem_exec_fence (basic-wait-all)
[521.533650] Starting subtest: basic-wait-all
[521.623247] Subtest basic-wait-all: SUCCESS (0.092s)
[523.445819] [130/131] (520s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[523.539254] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[530.208661] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.683s)
[530.324716] [131/131] (513s left) i915_pciid
[530.490204] Closing watchdogs
results: parsing output: 0/ for test: gem_basic
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: gem_workarounds
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_exec_nop
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_linear_blits
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_ccs
results: parsing output: 23/ for test: kms_chamelium_color
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: gem_sync
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_dirtyfb
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: sysfs_heartbeat_interval
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_pipe_b_c_ivb
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: i915_pm_rc6_residency
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_draw_crc
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: kms_plane_alpha_blend
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gen7_exec_parse
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: kms_properties
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_invalid_mode
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: gen3_render_tiledx_blits
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: dmabuf
results: parsing output: 96/ for test: gem_pwrite
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_color_pipeline
results: parsing output: 99/ for test: kms_vblank
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_psr2_su
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: gem_vm_create
results: parsing output: 116/ for test: i915_suspend
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_prime
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: sriov_basic
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: prime_mmap_coherency
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: i915_pciid
Done.