[57.126683] Initializing watchdogs
[57.126732]   /dev/watchdog0
[57.140679] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.144974] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.147103] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.150687] [001/132] (960s left) kms_content_protection (legacy-hdcp14)
[57.312947] Starting subtest: legacy-hdcp14
[57.317728] Subtest legacy-hdcp14: SKIP (0.000s)
[57.440606] [002/132] (960s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[57.529998] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[57.532496] Starting dynamic subtest: pipe-A-eDP-1
[58.750293] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.223s)
[58.758861] Starting dynamic subtest: pipe-B-eDP-1
[61.061443] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.310s)
[61.069791] Starting dynamic subtest: pipe-C-eDP-1
[63.323333] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.261s)
[63.332416] Starting dynamic subtest: pipe-D-eDP-1
[65.626363] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.302s)
[65.628789] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.100s)
[66.788107] [003/132] (950s left) gem_partial_pwrite_pread (reads-display)
[66.874909] Subtest reads-display: SKIP (0.000s)
[66.959522] [004/132] (950s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[67.188640] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[67.191146] Starting dynamic subtest: pipe-A-eDP-1
[67.211852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[67.221054] Starting dynamic subtest: pipe-B-eDP-1
[67.241307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[67.248477] Starting dynamic subtest: pipe-C-eDP-1
[67.268821] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[67.275914] Starting dynamic subtest: pipe-D-eDP-1
[67.296047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[67.298346] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[69.383413] [005/132] (948s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[69.489835] Starting subtest: fbc-modesetfrombusy
[73.237096] Subtest fbc-modesetfrombusy: SUCCESS (3.753s)
[74.395925] [006/132] (943s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[74.485366] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[74.489874] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[74.575922] [007/132] (943s left) gem_watchdog (default-virtual)
[74.659617] Starting subtest: default-virtual
[80.935767] Subtest default-virtual: SUCCESS (6.285s)
[81.013065] [008/132] (936s left) gem_barrier_race (remote-request)
[81.080173] Starting subtest: remote-request
[81.082667] Starting dynamic subtest: rcs0
[86.244862] Dynamic subtest rcs0: SUCCESS (5.163s)
[86.247230] Subtest remote-request: SUCCESS (5.163s)
[86.382094] [009/132] (931s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[86.481157] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[86.484832] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[86.587256] [010/132] (931s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[86.681903] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[86.683850] Starting dynamic subtest: pipe-A-eDP-1
[97.375762] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.698s)
[97.387744] Starting dynamic subtest: pipe-B-eDP-1
[108.796441] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.421s)
[108.798712] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.120s)
[109.642696] [011/132] (908s left) gem_tiled_partial_pwrite_pread (writes)
[109.703389] Subtest writes: SKIP (0.000s)
[109.770902] [012/132] (908s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[109.867143] Starting subtest: fbc-pr-cursor-mmap-cpu
[109.871534] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[109.932643] [013/132] (908s left) gem_render_copy (y-tiled)
[109.981856] Starting subtest: y-tiled
[109.986417] Subtest y-tiled: SKIP (0.000s)
[110.176312] [014/132] (907s left) gem_exec_balancer (busy)
[110.237312] Starting subtest: busy
[111.891882] Subtest busy: SUCCESS (1.653s)
[112.231770] [015/132] (905s left) kms_universal_plane (universal-plane-pageflip-windowed)
[112.329126] Starting subtest: universal-plane-pageflip-windowed
[112.331478] Starting dynamic subtest: pipe-A-eDP-1
[112.931876] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[112.940838] Starting dynamic subtest: pipe-B-eDP-1
[114.190397] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[114.199345] Starting dynamic subtest: pipe-C-eDP-1
[115.391985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[115.403240] Starting dynamic subtest: pipe-D-eDP-1
[116.611501] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[116.613915] Subtest universal-plane-pageflip-windowed: SUCCESS (4.284s)
[117.448845] [016/132] (900s left) gem_exec_store (dword)
[117.517150] Starting subtest: dword
[117.519144] Starting dynamic subtest: rcs0
[117.587770] Dynamic subtest rcs0: SUCCESS (0.073s)
[117.597166] Starting dynamic subtest: bcs0
[117.628359] Dynamic subtest bcs0: SUCCESS (0.040s)
[117.637719] Starting dynamic subtest: vcs0
[117.670215] Dynamic subtest vcs0: SUCCESS (0.041s)
[117.680076] Starting dynamic subtest: vcs1
[117.712249] Dynamic subtest vcs1: SUCCESS (0.041s)
[117.721296] Starting dynamic subtest: vecs0
[117.753018] Dynamic subtest vecs0: SUCCESS (0.040s)
[117.762129] Starting dynamic subtest: ccs0
[117.794564] Dynamic subtest ccs0: SUCCESS (0.040s)
[117.796937] Subtest dword: SUCCESS (0.281s)
[117.974930] [017/132] (900s left) gem_exec_balancer (sequential)
[118.048839] Starting subtest: sequential
[121.113239] Subtest sequential: SUCCESS (3.064s)
[121.418417] [018/132] (896s left) kms_cursor_edge_walk (64x64-right-edge)
[121.515841] Starting subtest: 64x64-right-edge
[121.518071] Starting dynamic subtest: pipe-A-eDP-1
[124.937108] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[124.945851] Starting dynamic subtest: pipe-D-eDP-1
[128.049660] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[128.052065] Subtest 64x64-right-edge: SUCCESS (6.535s)
[128.856146] [019/132] (889s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[129.066568] Starting subtest: cursor-rapid-movement-128x128
[129.071267] Starting dynamic subtest: pipe-A-eDP-1
[129.613510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[129.639504] Starting dynamic subtest: pipe-D-eDP-1
[130.871593] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[130.873975] Subtest cursor-rapid-movement-128x128: SUCCESS (1.805s)
[131.730093] [020/132] (886s left) kms_flip (2x-nonexisting-fb-interruptible)
[131.834749] Starting subtest: 2x-nonexisting-fb-interruptible
[131.845517] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[131.917505] [021/132] (886s left) kms_rotation_crc (cursor-rotation-180)
[132.011935] Starting subtest: cursor-rotation-180
[133.506627] Subtest cursor-rotation-180: SUCCESS (1.497s)
[134.675528] [022/132] (883s left) syncobj_basic (illegal-fd-to-handle)
[134.725805] Starting subtest: illegal-fd-to-handle
[134.728075] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[134.821609] [023/132] (883s left) sysfs_heartbeat_interval (invalid)
[134.865828] Starting subtest: invalid
[134.868129] Starting dynamic subtest: vecs0
[134.870301] Dynamic subtest vecs0: SUCCESS (0.000s)
[134.878319] Starting dynamic subtest: ccs0
[134.880455] Dynamic subtest ccs0: SUCCESS (0.000s)
[134.887087] Starting dynamic subtest: vcs0
[134.889264] Dynamic subtest vcs0: SUCCESS (0.000s)
[134.895723] Starting dynamic subtest: bcs0
[134.897566] Dynamic subtest bcs0: SUCCESS (0.000s)
[134.903990] Starting dynamic subtest: rcs0
[134.905862] Dynamic subtest rcs0: SUCCESS (0.000s)
[134.912212] Starting dynamic subtest: vcs1
[134.914099] Dynamic subtest vcs1: SUCCESS (0.000s)
[134.915919] Subtest invalid: SUCCESS (0.003s)
[134.948478] [024/132] (883s left) kms_plane (plane-panning-top-left)
[135.034828] Starting subtest: plane-panning-top-left
[135.036660] Starting dynamic subtest: pipe-A
[136.736217] Dynamic subtest pipe-A: SUCCESS (1.701s)
[136.745194] Starting dynamic subtest: pipe-B
[139.140928] Dynamic subtest pipe-B: SUCCESS (2.402s)
[139.142941] Subtest plane-panning-top-left: SUCCESS (4.105s)
[140.017559] [025/132] (878s left) gem_exec_flush (basic-wb-rw-before-default)
[140.076791] Starting subtest: basic-wb-rw-before-default
[145.537776] Subtest basic-wb-rw-before-default: SUCCESS (5.461s)
[145.723266] [026/132] (872s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[145.837212] Starting subtest: fbc-rgb565-draw-mmap-gtt
[145.841853] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[145.939618] [027/132] (872s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[145.997862] Starting subtest: invalid-bsd1-flag-on-blt
[146.000149] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[146.095123] [028/132] (872s left) kms_flip (wf_vblank-ts-check)
[146.200995] Starting subtest: wf_vblank-ts-check
[146.203302] Starting dynamic subtest: A-eDP1
[155.160451] Dynamic subtest A-eDP1: SUCCESS (8.959s)
[155.170805] Starting dynamic subtest: B-eDP1
[164.093593] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[164.103435] Starting dynamic subtest: C-eDP1
[173.019710] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[173.035410] Starting dynamic subtest: D-eDP1
[181.943142] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[181.945509] Subtest wf_vblank-ts-check: SUCCESS (35.742s)
[183.162277] [029/132] (835s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[183.265460] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[183.267846] Starting dynamic subtest: pipe-A-default-mode
[186.028847] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[186.030860] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.760s)
[186.862010] [030/132] (831s left) i915_hangman (gt-engine-error)
[186.934270] Starting subtest: gt-engine-error
[186.936259] Starting dynamic subtest: rcs0
[188.853674] Dynamic subtest rcs0: SUCCESS (1.919s)
[188.868192] Starting dynamic subtest: bcs0
[190.900248] Dynamic subtest bcs0: SUCCESS (2.044s)
[190.911766] Starting dynamic subtest: vcs0
[192.884223] Dynamic subtest vcs0: SUCCESS (1.981s)
[192.893977] Starting dynamic subtest: vcs1
[194.868468] Dynamic subtest vcs1: SUCCESS (1.982s)
[194.879305] Starting dynamic subtest: vecs0
[196.851481] Dynamic subtest vecs0: SUCCESS (1.982s)
[196.861222] Starting dynamic subtest: ccs0
[198.901035] Dynamic subtest ccs0: SUCCESS (2.047s)
[198.904025] Subtest gt-engine-error: SUCCESS (11.967s)
[198.995350] [031/132] (819s left) gem_mmap_gtt (fault-concurrent-x)
[199.046568] Subtest fault-concurrent-X: SKIP (0.000s)
[199.108266] [032/132] (819s left) gem_close_race (basic-threads)
[199.182990] Starting subtest: basic-threads
[200.601236] Subtest basic-threads: SUCCESS (1.418s)
[200.780826] [033/132] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[200.882774] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[200.887208] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[200.984194] [034/132] (817s left) gem_userptr_blits (sync-unmap)
[201.055949] Starting subtest: sync-unmap
[201.068763] Subtest sync-unmap: SUCCESS (0.014s)
[201.207930] [035/132] (817s left) gem_exec_schedule (preempt-hang)
[201.371097] Starting subtest: preempt-hang
[201.373756] Starting dynamic subtest: rcs0
[201.591247] Dynamic subtest rcs0: SUCCESS (0.219s)
[201.599479] Starting dynamic subtest: bcs0
[201.813408] Dynamic subtest bcs0: SUCCESS (0.221s)
[201.829558] Starting dynamic subtest: vcs0
[202.021270] Dynamic subtest vcs0: SUCCESS (0.208s)
[202.028912] Starting dynamic subtest: vcs1
[202.235845] Dynamic subtest vcs1: SUCCESS (0.213s)
[202.243821] Starting dynamic subtest: vecs0
[202.448975] Dynamic subtest vecs0: SUCCESS (0.213s)
[202.458552] Starting dynamic subtest: ccs0
[202.671470] Dynamic subtest ccs0: SUCCESS (0.222s)
[202.673846] Subtest preempt-hang: SUCCESS (1.301s)
[202.988828] [036/132] (816s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[203.041619] Subtest untiled-to-tiled: SKIP (0.000s)
[203.102211] [037/132] (815s left) syncobj_timeline (wait-any-snapshot)
[203.157649] Starting subtest: wait-any-snapshot
[203.238377] Subtest wait-any-snapshot: SUCCESS (0.082s)
[203.323837] [038/132] (815s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[203.431453] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[203.435639] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.530328] [039/132] (815s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[203.629899] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[204.662216] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.034s)
[204.772796] [040/132] (814s left) gem_exec_async (concurrent-writes)
[204.827856] Starting subtest: concurrent-writes
[204.830029] Starting dynamic subtest: rcs0
[204.843747] Dynamic subtest rcs0: SUCCESS (0.016s)
[204.851974] Starting dynamic subtest: bcs0
[204.853624] Dynamic subtest bcs0: SUCCESS (0.007s)
[204.861160] Starting dynamic subtest: vcs0
[204.862975] Dynamic subtest vcs0: SUCCESS (0.006s)
[204.870344] Starting dynamic subtest: vcs1
[204.872182] Dynamic subtest vcs1: SUCCESS (0.010s)
[204.879476] Starting dynamic subtest: vecs0
[204.881397] Dynamic subtest vecs0: SUCCESS (0.005s)
[204.890859] Starting dynamic subtest: ccs0
[204.892435] Dynamic subtest ccs0: SUCCESS (0.005s)
[204.893972] Subtest concurrent-writes: SUCCESS (0.052s)
[205.111876] [041/132] (814s left) gem_close_race (basic-process)
[205.191137] Starting subtest: basic-process
[205.231184] Subtest basic-process: SUCCESS (0.042s)
[205.411633] [042/132] (813s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[205.456690] Starting subtest: invalid-single-wait-all-unsubmitted
[205.458577] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[205.547271] [043/132] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[205.640084] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[205.644697] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[205.731909] [044/132] (813s left) syncobj_eventfd (binary-wait-signaled)
[205.790094] Starting subtest: binary-wait-signaled
[205.792182] Subtest binary-wait-signaled: SUCCESS (0.000s)
[205.901036] [045/132] (813s left) perf_pmu (rc6)
[205.944039] Starting subtest: rc6
[205.946264] Starting dynamic subtest: gt0
[212.312466] Dynamic subtest gt0: SUCCESS (6.367s)
[212.322779] Starting dynamic subtest: runtime-pm-gt0
[220.048430] Dynamic subtest runtime-pm-gt0: SUCCESS (7.734s)
[220.057560] Starting dynamic subtest: runtime-pm-long-gt0
[232.529077] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.478s)
[232.540152] Starting dynamic subtest: other-idle-gt0
[238.872091] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[238.883441] Starting dynamic subtest: gt1
[245.213448] Dynamic subtest gt1: SUCCESS (6.339s)
[245.224315] Starting dynamic subtest: runtime-pm-gt1
[252.716560] Dynamic subtest runtime-pm-gt1: SUCCESS (7.501s)
[252.727335] Starting dynamic subtest: runtime-pm-long-gt1
[265.152304] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.434s)
[265.161270] Starting dynamic subtest: other-idle-gt1
[271.497039] Dynamic subtest other-idle-gt1: SUCCESS (6.343s)
[271.499800] Subtest rc6: SUCCESS (65.552s)
[272.622532] [046/132] (746s left) kms_chamelium_hpd (vga-hpd)
[273.009829] Subtest vga-hpd: SKIP (0.000s)
[273.848238] [047/132] (745s left) kms_plane (pixel-format-yf-tiled-modifier)
[273.940055] Starting subtest: pixel-format-yf-tiled-modifier
[273.943981] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[273.985158] [048/132] (745s left) kms_addfb_basic (unused-handle)
[274.041404] Starting subtest: unused-handle
[274.043596] Subtest unused-handle: SUCCESS (0.000s)
[274.173801] [049/132] (745s left) gem_mmap_offset (mmap-unmap)
[274.232263] Starting subtest: mmap-unmap
[274.234522] Starting dynamic subtest: smem0
[297.323712] Dynamic subtest smem0: SUCCESS (23.089s)
[297.326706] Subtest mmap-unmap: SUCCESS (23.090s)
[297.407652] [050/132] (722s left) core_getversion (all-cards)
[297.465410] Starting subtest: all-cards
[297.469854] Subtest all-cards: SUCCESS (0.008s)
[297.531732] [051/132] (722s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[297.666860] Starting subtest: 2x-long-cursor-vs-flip-atomic
[297.671288] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[297.785029] [052/132] (721s left) syncobj_timeline (etime-multi-wait-submitted)
[297.838297] Starting subtest: etime-multi-wait-submitted
[297.945771] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[297.996218] [053/132] (721s left) kms_pipe_crc_basic (suspend-read-crc)
[298.092227] Starting subtest: suspend-read-crc
[298.094523] Starting dynamic subtest: pipe-A-eDP-1
[315.837492] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.689s)
[315.850686] Starting dynamic subtest: pipe-B-eDP-1
[333.838065] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.215s)
[333.848142] Starting dynamic subtest: pipe-C-eDP-1
[351.805350] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.117s)
[351.815845] Starting dynamic subtest: pipe-D-eDP-1
[369.784994] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.042s)
[369.787518] Subtest suspend-read-crc: SUCCESS (12.071s)
[370.586386] [054/132] (649s left) kms_psr (psr2-cursor-mmap-cpu)
[370.707291] Starting subtest: psr2-cursor-mmap-cpu
[370.709455] Starting dynamic subtest: eDP-1
[372.449811] Dynamic subtest eDP-1: SUCCESS (1.737s)
[372.452547] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.739s)
[373.264331] [055/132] (646s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[373.354966] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[373.357665] Starting dynamic subtest: pipe-A-eDP-1
[373.383618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.396058] Starting dynamic subtest: pipe-B-eDP-1
[373.421824] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.430804] Starting dynamic subtest: pipe-C-eDP-1
[373.456574] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.465034] Starting dynamic subtest: pipe-D-eDP-1
[373.491506] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.496562] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[375.537636] [056/132] (644s left) kms_flip (2x-flip-vs-dpms-on-nop)
[375.625121] Starting subtest: 2x-flip-vs-dpms-on-nop
[375.635678] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[375.698125] [057/132] (644s left) gem_pread (self)
[375.760738] Subtest self: SKIP (0.000s)
[375.821622] [058/132] (644s left) gem_exec_schedule (timeslicing)
[375.894972] Starting subtest: timeslicing
[375.897770] Starting dynamic subtest: rcs0
[375.903714] Dynamic subtest rcs0: SUCCESS (0.021s)
[375.912731] Starting dynamic subtest: bcs0
[375.923647] Dynamic subtest bcs0: SUCCESS (0.020s)
[375.933247] Starting dynamic subtest: vcs0
[375.945566] Dynamic subtest vcs0: SUCCESS (0.021s)
[375.954625] Starting dynamic subtest: vcs1
[375.965981] Dynamic subtest vcs1: SUCCESS (0.020s)
[375.975003] Starting dynamic subtest: vecs0
[375.987522] Dynamic subtest vecs0: SUCCESS (0.021s)
[375.996322] Starting dynamic subtest: ccs0
[376.011201] Dynamic subtest ccs0: SUCCESS (0.021s)
[376.014068] Subtest timeslicing: SUCCESS (0.130s)
[377.535917] [059/132] (642s left) api_intel_allocator (gem-pool)
[377.593753] Starting subtest: gem-pool
[377.599613] Subtest gem-pool: SUCCESS (0.009s)
[377.694338] [060/132] (642s left) gem_exec_reloc (basic-gtt-read-noreloc)
[377.758645] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[377.838749] [061/132] (642s left) kms_vblank (ts-continuation-idle)
[377.934860] Starting subtest: ts-continuation-idle
[377.937906] Starting dynamic subtest: pipe-A-eDP-1
[378.348656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[378.363903] Starting dynamic subtest: pipe-D-eDP-1
[379.462310] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[379.464967] Subtest ts-continuation-idle: SUCCESS (1.527s)
[380.315974] [062/132] (639s left) kms_getfb (getfb-handle-closed)
[380.420971] Starting subtest: getfb-handle-closed
[380.423763] Subtest getfb-handle-closed: SUCCESS (0.000s)
[380.487894] [063/132] (639s left) gem_exec_params (invalid-batch-start-offset)
[380.537495] Starting subtest: invalid-batch-start-offset
[380.540172] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[380.621030] [064/132] (639s left) sw_sync (sync_expired_merge)
[380.653726] Starting subtest: sync_expired_merge
[381.726494] Subtest sync_expired_merge: SUCCESS (1.074s)
[381.766831] [065/132] (638s left) kms_color_pipeline (plane-lut1d-lut1d)
[381.863418] Starting subtest: plane-lut1d-lut1d
[381.997982] Starting dynamic subtest: pipe-A-plane-0
[382.368278] Dynamic subtest pipe-A-plane-0: FAIL (0.172s)
[382.377042] Starting dynamic subtest: pipe-A-plane-1
[382.624840] Dynamic subtest pipe-A-plane-1: FAIL (0.168s)
[382.636387] Starting dynamic subtest: pipe-A-plane-2
[382.901685] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[383.770486] Starting dynamic subtest: pipe-B-plane-0
[384.273710] Dynamic subtest pipe-B-plane-0: FAIL (0.186s)
[384.283856] Starting dynamic subtest: pipe-B-plane-1
[384.635725] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[384.645094] Starting dynamic subtest: pipe-B-plane-2
[384.966620] Dynamic subtest pipe-B-plane-2: FAIL (0.673s)
[385.960987] Starting dynamic subtest: pipe-C-plane-0
[386.514392] Dynamic subtest pipe-C-plane-0: FAIL (0.128s)
[386.525018] Starting dynamic subtest: pipe-C-plane-1
[386.977725] Dynamic subtest pipe-C-plane-1: FAIL (0.696s)
[386.986285] Starting dynamic subtest: pipe-C-plane-2
[387.430602] Dynamic subtest pipe-C-plane-2: FAIL (0.174s)
[388.120620] Starting dynamic subtest: pipe-D-plane-0
[388.812718] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[388.823760] Starting dynamic subtest: pipe-D-plane-1
[389.345962] Dynamic subtest pipe-D-plane-1: FAIL (0.695s)
[389.355977] Starting dynamic subtest: pipe-D-plane-2
[389.882523] Dynamic subtest pipe-D-plane-2: FAIL (0.624s)
[389.884803] Subtest plane-lut1d-lut1d: FAIL (8.011s)
[390.664206] [066/132] (629s left) gem_eio (banned)
[390.903538] Starting subtest: banned
[391.518697] Subtest banned: SUCCESS (0.613s)
[391.642372] [067/132] (628s left) gem_ctx_persistence (saturated-hostile)
[391.691531] Starting subtest: saturated-hostile
[391.693741] Starting dynamic subtest: rcs0
[392.508259] Dynamic subtest rcs0: SUCCESS (0.815s)
[392.526424] Starting dynamic subtest: bcs0
[393.315185] Dynamic subtest bcs0: SUCCESS (0.805s)
[393.327542] Starting dynamic subtest: vcs0
[394.108753] Dynamic subtest vcs0: SUCCESS (0.791s)
[394.121255] Starting dynamic subtest: vcs1
[394.902610] Dynamic subtest vcs1: SUCCESS (0.791s)
[394.914973] Starting dynamic subtest: vecs0
[395.699961] Dynamic subtest vecs0: SUCCESS (0.795s)
[395.713187] Starting dynamic subtest: ccs0
[396.536970] Dynamic subtest ccs0: SUCCESS (0.834s)
[396.539855] Subtest saturated-hostile: SUCCESS (4.842s)
[396.636724] [068/132] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[396.755722] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[403.733993] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.977s)
[403.859502] [069/132] (616s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[403.960029] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[403.965511] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[404.015336] [070/132] (616s left) gem_ctx_param (invalid-get-no-zeromap)
[404.078459] Starting subtest: invalid-get-no-zeromap
[404.081385] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[404.146354] [071/132] (616s left) i915_pm_sseu (full-enable)
[404.207968] Subtest full-enable: SKIP (0.000s)
[404.271211] [072/132] (616s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[404.371682] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[411.407838] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.035s)
[411.497432] [073/132] (608s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[411.585967] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[411.588511] Starting dynamic subtest: pipe-A
[411.608436] Dynamic subtest pipe-A: SKIP (0.018s)
[411.618686] Starting dynamic subtest: pipe-B
[411.646272] Dynamic subtest pipe-B: SKIP (0.039s)
[411.654846] Starting dynamic subtest: pipe-C
[411.678672] Dynamic subtest pipe-C: SKIP (0.032s)
[411.687369] Starting dynamic subtest: pipe-D
[411.714565] Dynamic subtest pipe-D: SKIP (0.032s)
[411.719381] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.124s)
[411.777346] [074/132] (608s left) prime_busy (before-wait)
[411.851095] Starting subtest: before-wait
[411.857815] Starting dynamic subtest: rcs0
[411.886769] Dynamic subtest rcs0: SUCCESS (0.032s)
[411.897732] Starting dynamic subtest: bcs0
[411.936415] Dynamic subtest bcs0: SUCCESS (0.049s)
[411.946970] Starting dynamic subtest: vcs0
[411.977986] Dynamic subtest vcs0: SUCCESS (0.041s)
[411.988231] Starting dynamic subtest: vcs1
[412.020516] Dynamic subtest vcs1: SUCCESS (0.042s)
[412.031242] Starting dynamic subtest: vecs0
[412.063280] Dynamic subtest vecs0: SUCCESS (0.042s)
[412.073509] Starting dynamic subtest: ccs0
[412.105439] Dynamic subtest ccs0: SUCCESS (0.041s)
[412.213860] Subtest before-wait: SUCCESS (0.361s)
[412.270371] [075/132] (608s left) kms_psr (fbc-psr-cursor-plane-move)
[412.363977] Starting subtest: fbc-psr-cursor-plane-move
[412.366810] Starting dynamic subtest: eDP-1
[412.371882] Dynamic subtest eDP-1: SKIP (0.000s)
[412.377348] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[412.414499] [076/132] (608s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[412.510610] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[413.390365] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.881s)
[413.529096] [077/132] (607s left) gem_mmap_gtt (basic-small-bo-tiledy)
[413.592461] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[413.659868] [078/132] (606s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[413.704907] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[413.706956] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[413.774336] [079/132] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[413.868228] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[413.872759] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[413.925917] [080/132] (606s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[413.978755] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[414.033804] [081/132] (606s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[414.134733] Starting subtest: multiplane-rotation-cropping-bottom
[431.735726] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.593s)
[431.819593] [082/132] (588s left) kms_chamelium_color (degamma)
[431.924403] Subtest degamma: SKIP (0.000s)
[431.970111] [083/132] (588s left) gem_render_copy (yf-tiled)
[432.032694] Starting subtest: yf-tiled
[432.037433] Subtest yf-tiled: SKIP (0.000s)
[432.192837] [084/132] (588s left) kms_async_flips (async-flip-suspend-resume)
[432.286961] Starting subtest: async-flip-suspend-resume
[432.654450] Starting dynamic subtest: pipe-A-eDP-1
[451.064008] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.058s)
[451.459720] Starting dynamic subtest: pipe-B-eDP-1
[469.071661] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.054s)
[469.439054] Starting dynamic subtest: pipe-C-eDP-1
[486.896019] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.859s)
[487.273303] Starting dynamic subtest: pipe-D-eDP-1
[505.139082] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[505.142365] Subtest async-flip-suspend-resume: SUCCESS (13.589s)
[506.294870] [085/132] (514s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[506.399913] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[515.001026] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.593s)
[515.079460] [086/132] (505s left) gem_mmap_gtt (basic-write-read-distinct)
[515.150149] Subtest basic-write-read-distinct: SKIP (0.000s)
[515.222199] [087/132] (505s left) prime_mmap_coherency (ioctl-errors)
[515.275529] Starting subtest: ioctl-errors
[538.763698] Subtest ioctl-errors: SUCCESS (23.471s)
[538.883737] [088/132] (482s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[539.034587] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[539.039536] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[539.085583] [089/132] (482s left) gem_softpin (allocator-nopin-reserve)
[539.148721] Starting subtest: allocator-nopin-reserve
[539.236237] Subtest allocator-nopin-reserve: SUCCESS (0.090s)
[539.325504] [090/132] (481s left) kms_mmap_write_crc (main)
[539.418818] Starting subtest: main
[539.420871] Starting dynamic subtest: pipe-A-eDP-1
[542.849004] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[542.851022] Subtest main: SUCCESS (3.430s)
[543.718509] [091/132] (477s left) kms_atomic (atomic-plane-damage)
[543.820062] Starting subtest: atomic-plane-damage
[543.868895] Starting dynamic subtest: pipe-A-eDP-1
[544.421175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[544.424232] Subtest atomic-plane-damage: SUCCESS (0.603s)
[545.239229] [092/132] (475s left) kms_atomic_interruptible (universal-setplane-cursor)
[545.350808] Starting subtest: universal-setplane-cursor
[545.353061] Starting dynamic subtest: pipe-A-eDP-1
[552.769225] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s)
[552.771992] Subtest universal-setplane-cursor: SUCCESS (7.418s)
[553.604103] [093/132] (467s left) gem_ctx_engines (execute-oneforall)
[553.666471] Starting subtest: execute-oneforall
[554.233925] Subtest execute-oneforall: SUCCESS (0.567s)
[555.845445] [094/132] (465s left) gem_gpgpu_fill (offset-16x16)
[555.904207] Starting subtest: offset-16x16
[555.911157] Subtest offset-16x16: SUCCESS (0.008s)
[556.003262] [095/132] (465s left) syncobj_timeline (multi-wait-signaled)
[556.063135] Starting subtest: multi-wait-signaled
[556.065592] Subtest multi-wait-signaled: SUCCESS (0.001s)
[556.134315] [096/132] (465s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[556.191132] Starting subtest: invalid-bsd2-flag-on-vebox
[556.193574] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[556.275744] [097/132] (465s left) perf_pmu (init-busy)
[556.320043] Starting subtest: init-busy
[556.322450] Starting dynamic subtest: rcs0
[556.325052] Dynamic subtest rcs0: SUCCESS (0.001s)
[556.335623] Starting dynamic subtest: bcs0
[556.338052] Dynamic subtest bcs0: SUCCESS (0.000s)
[556.348524] Starting dynamic subtest: vcs0
[556.350790] Dynamic subtest vcs0: SUCCESS (0.001s)
[556.361319] Starting dynamic subtest: vcs1
[556.364132] Dynamic subtest vcs1: SUCCESS (0.000s)
[556.375190] Starting dynamic subtest: vecs0
[556.377850] Dynamic subtest vecs0: SUCCESS (0.000s)
[556.387328] Starting dynamic subtest: ccs0
[556.390173] Dynamic subtest ccs0: SUCCESS (0.000s)
[556.392919] Subtest init-busy: SUCCESS (0.007s)
[556.436331] [098/132] (465s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[556.537086] Starting subtest: primary-yf-tiled-reflect-x-90
[556.542154] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[556.587610] [099/132] (464s left) kms_psr (fbc-psr2-primary-page-flip)
[556.679038] Starting subtest: fbc-psr2-primary-page-flip
[556.681799] Starting dynamic subtest: eDP-1
[556.686869] Dynamic subtest eDP-1: SKIP (0.000s)
[556.691686] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[556.728797] [100/132] (464s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[556.832718] Starting subtest: x-tiled-64bpp-rotate-270
[556.857512] Subtest x-tiled-64bpp-rotate-270: SKIP (0.024s)
[556.942559] [101/132] (464s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[557.042338] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[557.046739] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[557.124720] [102/132] (464s left) syncobj_wait (reset-during-wait-for-submit)
[557.184578] Starting subtest: reset-during-wait-for-submit
[557.285964] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[557.341062] [103/132] (464s left) kms_feature_discovery (psr2)
[557.437223] Starting subtest: psr2
[557.439980] Subtest psr2: SUCCESS (0.000s)
[557.488687] [104/132] (464s left) gem_ringfill (basic-all)
[562.784459] Starting subtest: basic-all
[563.948266] Subtest basic-all: SUCCESS (1.163s)
[564.047250] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[564.050933] [105/132] (457s left) kms_pm_rpm (drm-resources-equal)
[565.988339] Starting subtest: drm-resources-equal
[571.019363] Subtest drm-resources-equal: SUCCESS (5.034s)
[571.089445] [106/132] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[571.183831] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[577.995355] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.812s)
[578.076912] [107/132] (443s left) kms_dp_linktrain_fallback (dp-fallback)
[578.176513] Starting subtest: dp-fallback
[578.184349] Subtest dp-fallback: SKIP (0.000s)
[578.228647] [108/132] (443s left) kms_cursor_crc (cursor-onscreen-32x10)
[578.399596] Starting subtest: cursor-onscreen-32x10
[578.448341] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[578.681579] [109/132] (443s left) gen7_exec_parse (batch-without-end)
[578.742140] Subtest batch-without-end: SKIP (0.000s)
[578.817705] [110/132] (443s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[578.919322] Starting subtest: yf-tiled-32bpp-rotate-0
[578.924150] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[578.992534] [111/132] (443s left) perf_pmu (busy-hang)
[579.036965] Starting subtest: busy-hang
[579.039204] Starting dynamic subtest: rcs0
[580.296056] Dynamic subtest rcs0: SUCCESS (1.261s)
[580.314048] Starting dynamic subtest: bcs0
[581.530638] Dynamic subtest bcs0: SUCCESS (1.232s)
[581.543346] Starting dynamic subtest: vcs0
[583.255928] Dynamic subtest vcs0: SUCCESS (1.723s)
[583.267956] Starting dynamic subtest: vcs1
[585.305967] Dynamic subtest vcs1: SUCCESS (2.048s)
[585.318189] Starting dynamic subtest: vecs0
[587.293156] Dynamic subtest vecs0: SUCCESS (1.985s)
[587.305736] Starting dynamic subtest: ccs0
[588.536138] Dynamic subtest ccs0: SUCCESS (1.237s)
[588.538935] Subtest busy-hang: SUCCESS (9.496s)
[588.601723] [112/132] (433s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[588.703121] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[588.705810] Starting dynamic subtest: pipe-A-eDP-1
[588.732465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[588.743961] Starting dynamic subtest: pipe-B-eDP-1
[588.770101] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[588.781285] Starting dynamic subtest: pipe-C-eDP-1
[588.807113] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[588.817079] Starting dynamic subtest: pipe-D-eDP-1
[588.842882] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[588.847892] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[590.927551] [113/132] (431s left) kms_psr (psr2-sprite-render)
[591.026327] Starting subtest: psr2-sprite-render
[591.028740] Starting dynamic subtest: eDP-1
[592.745194] Dynamic subtest eDP-1: SUCCESS (1.718s)
[592.747796] Subtest psr2-sprite-render: SUCCESS (1.719s)
[593.598648] [114/132] (428s left) gem_exec_params (secure-non-master)
[593.663223] Starting subtest: secure-non-master
[593.669107] Subtest secure-non-master: SKIP (0.000s)
[593.744820] [115/132] (428s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[593.828245] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[593.833218] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[593.878973] [116/132] (428s left) gem_exec_reloc (basic-wc-cpu)
[593.952189] Subtest basic-wc-cpu: SKIP (0.000s)
[594.023206] [117/132] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[594.125342] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[594.130620] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[594.208197] [118/132] (428s left) kms_invalid_mode (bad-hsync-start)
[594.307898] Starting subtest: bad-hsync-start
[594.310336] Starting dynamic subtest: pipe-A-eDP-1
[594.593759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[594.605233] Starting dynamic subtest: pipe-B-eDP-1
[594.608216] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[594.619003] Starting dynamic subtest: pipe-C-eDP-1
[594.621629] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[594.631569] Starting dynamic subtest: pipe-D-eDP-1
[594.634247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[594.637147] Subtest bad-hsync-start: SUCCESS (0.293s)
[595.432589] [119/132] (426s left) core_auth (getclient-master-drop)
[595.469344] Starting subtest: getclient-master-drop
[595.484923] Subtest getclient-master-drop: SUCCESS (0.018s)
[595.574751] [120/132] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[595.671438] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[603.000333] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.329s)
[603.105413] [121/132] (419s left) i915_drm_fdinfo (memory-info-idle)
[603.172859] Starting subtest: memory-info-idle
[603.175612] Starting dynamic subtest: smem0
[603.226241] Dynamic subtest smem0: SUCCESS (0.056s)
[603.229339] Subtest memory-info-idle: SUCCESS (0.059s)
[603.308109] [122/132] (419s left) kms_pm_rpm (i2c)
[604.831611] Starting subtest: i2c
[610.531238] Subtest i2c: SUCCESS (5.704s)
[610.600453] [123/132] (411s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[610.700334] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[610.705378] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[610.770696] [124/132] (411s left) gem_exec_fence (long-history)
[611.198407] Starting subtest: long-history
[618.411215] Subtest long-history: SUCCESS (7.216s)
[619.208585] [125/132] (403s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[619.337900] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[619.343226] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[619.460360] [126/132] (403s left) i915_pm_rpm (reg-read-ioctl)
[620.977763] Starting subtest: reg-read-ioctl
[623.374230] Subtest reg-read-ioctl: SUCCESS (2.397s)
[623.740825] [127/132] (398s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[623.840197] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[623.845562] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[623.908765] [128/132] (398s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[624.006638] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[630.812602] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.810s)
[630.907964] [129/132] (391s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[631.013712] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[631.016178] Starting dynamic subtest: pipe-A-eDP-1
[631.026791] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[631.037086] Starting dynamic subtest: pipe-B-eDP-1
[631.047230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[631.057024] Starting dynamic subtest: pipe-C-eDP-1
[631.067863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[631.077128] Starting dynamic subtest: pipe-D-eDP-1
[631.087334] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[631.092137] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[633.157787] [130/132] (389s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[633.254738] Starting subtest: fbcpsr-indfb-scaledprimary
[639.044357] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.795s)
[639.158139] [131/132] (383s left) kms_flip (flip-vs-expired-vblank)
[639.250473] Starting subtest: flip-vs-expired-vblank
[639.253100] Starting dynamic subtest: A-eDP1
[647.899274] Dynamic subtest A-eDP1: SUCCESS (8.650s)
[647.910576] Starting dynamic subtest: B-eDP1
[656.541988] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[656.553388] Starting dynamic subtest: C-eDP1
[665.173448] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[665.194888] Starting dynamic subtest: D-eDP1
[673.806411] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[673.809173] Subtest flip-vs-expired-vblank: SUCCESS (34.558s)
[674.976938] [132/132] (347s left) gem_partial_pwrite_pread (write)
[675.042271] Subtest write: SKIP (0.000s)
[675.117413] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_partial_pwrite_pread
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: gem_watchdog
results: parsing output: 7/ for test: gem_barrier_race
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_universal_plane
results: parsing output: 15/ for test: gem_exec_store
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_cursor_edge_walk
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: sysfs_heartbeat_interval
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: i915_hangman
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: gem_close_race
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_exec_async
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_eventfd
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: core_getversion
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_pread
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: api_intel_allocator
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_vblank
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_color_pipeline
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: i915_pm_sseu
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: kms_chamelium_color
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: prime_mmap_coherency
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: kms_mmap_write_crc
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: kms_atomic_interruptible
results: parsing output: 92/ for test: gem_ctx_engines
results: parsing output: 93/ for test: gem_gpgpu_fill
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: gem_ringfill
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_dp_linktrain_fallback
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gen7_exec_parse
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_invalid_mode
results: parsing output: 118/ for test: core_auth
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: i915_pm_rpm
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gem_partial_pwrite_pread
Done.