[56.024966] Initializing watchdogs
[56.025135]   /dev/watchdog0
[56.038641] [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.042697] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.044827] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.048142] [001/129] (960s left) gem_exec_reloc (basic-gtt)
[56.180869] Subtest basic-gtt: SKIP (0.000s)
[56.238856] [002/129] (960s left) gem_gpgpu_fill (basic)
[56.291044] Starting subtest: basic
[56.293413] Starting dynamic subtest: smem
[56.297949] Dynamic subtest smem: SUCCESS (0.007s)
[56.300412] Subtest basic: SUCCESS (0.007s)
[56.416737] [003/129] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[56.522264] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[56.526558] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[56.639574] [004/129] (960s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[56.705982] Starting subtest: mixed-tiled-to-y-tiled-ccs
[56.710483] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[56.883893] [005/129] (959s left) kms_cursor_edge_walk (256x256-left-edge)
[56.981298] Starting subtest: 256x256-left-edge
[56.983871] Starting dynamic subtest: pipe-A-eDP-1
[60.462071] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[60.468917] Starting dynamic subtest: pipe-D-eDP-1
[63.583138] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[63.585536] Subtest 256x256-left-edge: SUCCESS (6.600s)
[64.374806] [006/129] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[64.483460] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[64.487722] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[64.575323] [007/129] (952s left) gem_ctx_persistence (hang)
[64.635113] Starting subtest: hang
[64.639857] Subtest hang: SKIP (0.000s)
[64.739112] [008/129] (952s left) gem_exec_balancer (hog)
[64.808172] Starting subtest: hog
[64.812708] Subtest hog: SKIP (0.000s)
[65.108839] [009/129] (951s left) perf_pmu (busy-check-all)
[65.145698] Starting subtest: busy-check-all
[65.148081] Starting dynamic subtest: rcs0
[65.718156] Dynamic subtest rcs0: SUCCESS (0.572s)
[65.727453] Starting dynamic subtest: bcs0
[66.265644] Dynamic subtest bcs0: SUCCESS (0.548s)
[66.274801] Starting dynamic subtest: vcs0
[67.947432] Dynamic subtest vcs0: SUCCESS (1.679s)
[67.957689] Starting dynamic subtest: vcs1
[69.931087] Dynamic subtest vcs1: SUCCESS (1.983s)
[69.940860] Starting dynamic subtest: vecs0
[71.914054] Dynamic subtest vecs0: SUCCESS (1.983s)
[71.924171] Starting dynamic subtest: ccs0
[72.469638] Dynamic subtest ccs0: SUCCESS (0.557s)
[72.473096] Subtest busy-check-all: SUCCESS (7.324s)
[72.572915] [010/129] (944s left) kms_chamelium_frames (dp-frame-dump)
[72.964411] Subtest dp-frame-dump: SKIP (0.000s)
[73.779171] [011/129] (943s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[73.887060] Starting subtest: 4-tiled-32bpp-rotate-180
[75.467111] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.580s)
[75.635477] [012/129] (941s left) gem_userptr_blits (unsync-unmap)
[75.703606] Subtest unsync-unmap: SKIP (0.000s)
[75.835190] [013/129] (941s left) sysfs_heartbeat_interval (idempotent)
[75.902232] Starting subtest: idempotent
[75.904313] Starting dynamic subtest: vecs0
[75.906542] Dynamic subtest vecs0: SUCCESS (0.001s)
[75.915310] Starting dynamic subtest: ccs0
[75.916903] Dynamic subtest ccs0: SUCCESS (0.001s)
[75.923212] Starting dynamic subtest: vcs0
[75.924815] Dynamic subtest vcs0: SUCCESS (0.000s)
[75.930990] Starting dynamic subtest: bcs0
[75.932624] Dynamic subtest bcs0: SUCCESS (0.001s)
[75.938693] Starting dynamic subtest: rcs0
[75.940360] Dynamic subtest rcs0: SUCCESS (0.000s)
[75.946417] Starting dynamic subtest: vcs1
[75.948087] Dynamic subtest vcs1: SUCCESS (0.000s)
[75.950071] Subtest idempotent: SUCCESS (0.005s)
[76.002665] [014/129] (940s left) gem_exec_schedule (fifo)
[76.072497] Starting subtest: fifo
[76.074608] Starting dynamic subtest: rcs0
[76.155551] Dynamic subtest rcs0: SUCCESS (0.089s)
[76.166693] Starting dynamic subtest: vcs0
[76.227674] Dynamic subtest vcs0: SUCCESS (0.072s)
[76.236273] Starting dynamic subtest: vcs1
[76.304149] Dynamic subtest vcs1: SUCCESS (0.076s)
[76.313086] Starting dynamic subtest: vecs0
[76.379521] Dynamic subtest vecs0: SUCCESS (0.075s)
[76.389707] Starting dynamic subtest: ccs0
[76.452146] Dynamic subtest ccs0: SUCCESS (0.073s)
[76.454223] Subtest fifo: SUCCESS (0.386s)
[78.036255] [015/129] (938s left) kms_plane_cursor (viewport)
[78.132995] Starting subtest: viewport
[78.137617] Starting dynamic subtest: pipe-A-eDP-1-size-64
[80.962567] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.828s)
[81.021324] Starting dynamic subtest: pipe-A-eDP-1-size-128
[83.842530] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.827s)
[83.900763] Starting dynamic subtest: pipe-A-eDP-1-size-256
[86.677087] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.782s)
[87.024612] Starting dynamic subtest: pipe-B-eDP-1-size-64
[90.571257] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.554s)
[90.628511] Starting dynamic subtest: pipe-B-eDP-1-size-128
[93.449334] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.826s)
[93.508349] Starting dynamic subtest: pipe-B-eDP-1-size-256
[96.317635] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.815s)
[96.661402] Starting dynamic subtest: pipe-C-eDP-1-size-64
[99.766557] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.113s)
[99.802223] Starting dynamic subtest: pipe-C-eDP-1-size-128
[102.233081] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.435s)
[102.269308] Starting dynamic subtest: pipe-C-eDP-1-size-256
[104.722084] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.457s)
[105.049048] Starting dynamic subtest: pipe-D-eDP-1-size-64
[108.145078] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.106s)
[108.181844] Starting dynamic subtest: pipe-D-eDP-1-size-128
[110.689381] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.513s)
[110.729171] Starting dynamic subtest: pipe-D-eDP-1-size-256
[113.133204] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.413s)
[113.453893] Subtest viewport: SUCCESS (35.315s)
[114.302566] [016/129] (902s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[114.370619] Starting subtest: multi-wait-all-for-submit-available-submitted
[114.373094] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[114.465146] [017/129] (902s left) kms_flip (flip-vs-blocking-wf-vblank)
[114.560166] Starting subtest: flip-vs-blocking-wf-vblank
[114.562526] Starting dynamic subtest: A-eDP1
[123.542066] Dynamic subtest A-eDP1: SUCCESS (8.981s)
[123.550228] Starting dynamic subtest: B-eDP1
[132.466429] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[132.474530] Starting dynamic subtest: C-eDP1
[141.382051] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[141.390164] Starting dynamic subtest: D-eDP1
[150.310924] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[150.313354] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.753s)
[151.528819] [018/129] (865s left) gem_exec_store (pages)
[151.595349] Starting subtest: pages
[151.597634] Starting dynamic subtest: rcs0
[151.714322] Dynamic subtest rcs0: SUCCESS (0.120s)
[151.723857] Starting dynamic subtest: bcs0
[151.798052] Dynamic subtest bcs0: SUCCESS (0.083s)
[151.807525] Starting dynamic subtest: vcs0
[151.873778] Dynamic subtest vcs0: SUCCESS (0.074s)
[151.883535] Starting dynamic subtest: vcs1
[151.950891] Dynamic subtest vcs1: SUCCESS (0.077s)
[151.959188] Starting dynamic subtest: vecs0
[152.017078] Dynamic subtest vecs0: SUCCESS (0.065s)
[152.026413] Starting dynamic subtest: ccs0
[152.090716] Dynamic subtest ccs0: SUCCESS (0.072s)
[152.093403] Subtest pages: SUCCESS (0.498s)
[152.267877] [019/129] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[152.370330] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[157.751908] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.383s)
[157.889334] [020/129] (859s left) gem_create (create-ext-cpu-access-big)
[158.066315] Starting subtest: create-ext-cpu-access-big
[158.071399] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[158.133558] [021/129] (859s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[158.262081] Starting subtest: 2x-long-cursor-vs-flip-atomic
[158.266422] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[158.363570] [022/129] (858s left) gem_ctx_shared (detached-shared-gtt)
[158.427843] Starting subtest: detached-shared-gtt
[160.580153] Subtest detached-shared-gtt: SUCCESS (2.151s)
[160.926558] [023/129] (856s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[161.041536] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[161.045642] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[161.137818] [024/129] (856s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[166.136742] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[166.138888] Starting dynamic subtest: pipe-A-eDP-1
[166.933132] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[166.941081] Starting dynamic subtest: pipe-B-eDP-1
[168.059313] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[168.063611] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.920s)
[169.238651] [025/129] (848s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[169.368477] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[169.372716] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[169.458982] [026/129] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[169.561495] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[174.415073] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.855s)
[174.543910] [027/129] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[174.646586] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[174.651022] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.749241] [028/129] (842s left) gem_exec_whisper (basic-contexts)
[174.814534] Starting subtest: basic-contexts
[182.858207] Subtest basic-contexts: SUCCESS (8.039s)
[183.034752] [029/129] (834s left) prime_mmap_coherency (read)
[183.095938] Starting subtest: read
[188.477247] Subtest read: SUCCESS (5.380s)
[188.600766] [030/129] (828s left) i915_pm_rps (thresholds)
[188.672159] Starting subtest: thresholds
[188.676745] Subtest thresholds: SKIP (0.000s)
[188.743958] [031/129] (828s left) api_intel_allocator (execbuf-with-allocator)
[188.820511] Starting subtest: execbuf-with-allocator
[188.829355] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[188.964829] [032/129] (828s left) gem_userptr_blits (invalid-null-pointer)
[189.030135] Starting subtest: invalid-null-pointer
[189.032487] Subtest invalid-null-pointer: SUCCESS (0.001s)
[189.157380] [033/129] (828s left) kms_psr (fbc-pr-cursor-blt)
[189.266059] Starting subtest: fbc-pr-cursor-blt
[189.270141] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[189.331269] [034/129] (828s left) kms_prime (basic-crc-vgem)
[191.550306] Starting subtest: basic-crc-vgem
[191.552526] Starting dynamic subtest: second-to-first
[192.479052] Dynamic subtest second-to-first: SUCCESS (0.930s)
[192.481501] Subtest basic-crc-vgem: SUCCESS (0.931s)
[192.554102] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.amdgpu: true
[192.554637] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[192.554764] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.xe: true
[192.557511] [035/129] (825s left) kms_cursor_crc (cursor-suspend)
[192.714243] Starting subtest: cursor-suspend
[192.716143] Starting dynamic subtest: pipe-A-eDP-1
[225.585649] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.154s)
[225.594843] Starting dynamic subtest: pipe-D-eDP-1
[258.585397] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.671s)
[258.587838] Subtest cursor-suspend: SUCCESS (6.828s)
[259.369474] [036/129] (817s left) gen9_exec_parse (allowed-single)
[259.428702] Subtest allowed-single: SKIP (0.000s)
[259.506671] [037/129] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[259.613080] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[263.144216] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.533s)
[263.276023] [038/129] (813s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[263.385824] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[263.475978] [039/129] (813s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[263.535795] Starting subtest: invalid-multi-wait-unsubmitted
[263.537821] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[263.653194] [040/129] (813s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[263.750783] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[263.754286] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[263.864307] [041/129] (813s left) kms_busy (extended-pageflip-hang-newfb)
[263.966133] Starting subtest: extended-pageflip-hang-newfb
[263.968196] Starting dynamic subtest: pipe-A
[291.735173] Dynamic subtest pipe-A: SUCCESS (27.758s)
[291.744593] Starting dynamic subtest: pipe-D
[306.788724] Dynamic subtest pipe-D: SUCCESS (15.051s)
[306.791195] Subtest extended-pageflip-hang-newfb: SUCCESS (42.813s)
[307.659802] [042/129] (769s left) gem_tiled_partial_pwrite_pread (reads)
[307.719659] Subtest reads: SKIP (0.000s)
[307.781239] [043/129] (769s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[307.881722] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[307.893295] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[307.972647] [044/129] (769s left) kms_psr (psr2-primary-page-flip)
[308.073265] Starting subtest: psr2-primary-page-flip
[308.075711] Starting dynamic subtest: eDP-1
[309.848086] Dynamic subtest eDP-1: SUCCESS (1.775s)
[309.850418] Subtest psr2-primary-page-flip: SUCCESS (1.776s)
[310.712999] [045/129] (766s left) kms_vrr (max-min)
[310.812605] Starting subtest: max-min
[310.819077] Subtest max-min: SKIP (0.000s)
[310.883706] [046/129] (766s left) gem_wait (invalid-flags)
[310.949849] Starting subtest: invalid-flags
[310.952190] Subtest invalid-flags: SUCCESS (0.000s)
[311.182272] [047/129] (765s left) gem_softpin (zero)
[311.245752] Starting subtest: zero
[311.253013] Subtest zero: SUCCESS (0.005s)
[311.373917] [048/129] (765s left) prime_mmap (test_correct)
[311.434945] Starting subtest: test_correct
[311.437310] Starting dynamic subtest: test_correct-smem
[311.469260] Dynamic subtest test_correct-smem: SUCCESS (0.035s)
[311.471837] Subtest test_correct: SUCCESS (0.036s)
[311.556857] [049/129] (765s left) kms_pm_rpm (fences-dpms)
[313.095720] Starting subtest: fences-dpms
[313.100944] Subtest fences-dpms: SKIP (0.000s)
[313.855270] [050/129] (763s left) prime_mmap (test_map_unmap)
[313.920617] Starting subtest: test_map_unmap
[313.922840] Starting dynamic subtest: test_map_unmap-smem
[313.952029] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[313.954484] Subtest test_map_unmap: SUCCESS (0.034s)
[314.066928] [051/129] (763s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[314.158755] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[314.161127] Starting dynamic subtest: pipe-A-eDP-1
[315.485139] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.323s)
[315.761400] Starting dynamic subtest: pipe-B-eDP-1
[316.801754] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[317.064824] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.906s)
[317.906904] [052/129] (759s left) gem_mmap_offset (ptrace)
[317.963306] Starting subtest: ptrace
[317.965518] Starting dynamic subtest: smem0-wb
[317.985239] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[317.993777] Starting dynamic subtest: smem0-wc
[318.004862] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[318.013270] Starting dynamic subtest: smem0-uc
[318.025302] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[318.027487] Subtest ptrace: SUCCESS (0.065s)
[318.143232] [053/129] (759s left) kms_chamelium_frames (vga-frame-dump)
[318.534836] Subtest vga-frame-dump: SKIP (0.000s)
[319.310898] [054/129] (758s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[319.423505] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[319.425884] Starting dynamic subtest: pipe-A-default-mode
[319.729549] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[319.734133] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.301s)
[320.566260] [055/129] (756s left) kms_dsc (dsc-fractional-bpp)
[320.674599] Starting subtest: dsc-fractional-bpp
[320.687348] Subtest dsc-fractional-bpp: SKIP (0.000s)
[320.744514] [056/129] (756s left) gem_mmap_wc (read)
[320.809311] Subtest read: SKIP (0.000s)
[320.869767] [057/129] (756s left) gem_flink_basic (double-flink)
[320.934206] Starting subtest: double-flink
[320.936928] Subtest double-flink: SUCCESS (0.000s)
[321.039169] [058/129] (756s left) kms_fbcon_fbt (fbc)
[321.091679] Starting subtest: fbc
[326.333676] Subtest fbc: SUCCESS (5.240s)
[326.406701] [059/129] (751s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[326.500218] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[326.502468] Starting dynamic subtest: A-eDP1
[330.119821] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[330.129335] Starting dynamic subtest: B-eDP1
[333.291124] Dynamic subtest B-eDP1: SUCCESS (3.169s)
[333.301743] Starting dynamic subtest: C-eDP1
[336.372294] Dynamic subtest C-eDP1: SUCCESS (3.082s)
[336.381715] Starting dynamic subtest: D-eDP1
[339.449215] Dynamic subtest D-eDP1: SUCCESS (3.075s)
[339.451990] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.949s)
[340.244370] [060/129] (737s left) kms_sequence (queue-idle)
[340.342610] Starting subtest: queue-idle
[340.345017] Starting dynamic subtest: pipe-A-eDP-1
[342.169172] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[342.177756] Starting dynamic subtest: pipe-B-eDP-1
[344.616810] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.444s)
[344.625407] Starting dynamic subtest: pipe-C-eDP-1
[347.031646] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[347.040948] Starting dynamic subtest: pipe-D-eDP-1
[349.461285] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[349.463562] Subtest queue-idle: SUCCESS (9.117s)
[350.262109] [061/129] (727s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[350.353465] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[350.358107] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[351.480893] [062/129] (726s left) gem_ctx_isolation (nonpriv)
[351.537695] Starting subtest: nonpriv
[351.540129] Starting dynamic subtest: rcs0
[352.053823] Dynamic subtest rcs0: SUCCESS (0.515s)
[352.064408] Starting dynamic subtest: bcs0
[352.638363] Dynamic subtest bcs0: SUCCESS (0.584s)
[352.648261] Starting dynamic subtest: vcs0
[353.205470] Dynamic subtest vcs0: SUCCESS (0.566s)
[353.213622] Starting dynamic subtest: vcs1
[354.541093] Dynamic subtest vcs1: SUCCESS (1.335s)
[354.552208] Starting dynamic subtest: vecs0
[356.522880] Dynamic subtest vecs0: SUCCESS (1.981s)
[356.533018] Starting dynamic subtest: ccs0
[358.593442] Dynamic subtest ccs0: SUCCESS (2.070s)
[358.596314] Subtest nonpriv: SUCCESS (7.056s)
[358.840188] [063/129] (718s left) kms_pm_dc (dc5-retention-flops)
[359.958329] Starting subtest: dc5-retention-flops
[359.962546] Subtest dc5-retention-flops: SKIP (0.000s)
[360.028217] [064/129] (717s left) kms_3d
[362.392970] [065/129] (715s left) gem_exec_fence (syncobj-wait)
[362.824134] Starting subtest: syncobj-wait
[364.008838] Subtest syncobj-wait: SUCCESS (1.183s)
[364.366876] [066/129] (713s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[369.384888] Starting subtest: pr-primary-plane-update-sf-dmg-area
[369.389717] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[370.198434] [067/129] (707s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[370.305592] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[370.308037] Starting dynamic subtest: pipe-A-eDP-1
[370.368284] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[370.378739] Starting dynamic subtest: pipe-B-eDP-1
[370.438449] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[370.448415] Starting dynamic subtest: pipe-C-eDP-1
[370.506847] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[370.517568] Starting dynamic subtest: pipe-D-eDP-1
[370.576422] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[370.581031] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[372.518335] [068/129] (705s left) perf (polling-parameterized)
[372.628981] Starting subtest: polling-parameterized
[392.664325] Subtest polling-parameterized: SUCCESS (20.033s)
[392.708739] [069/129] (685s left) syncobj_eventfd (binary-wait-signaled)
[392.764439] Starting subtest: binary-wait-signaled
[392.766654] Subtest binary-wait-signaled: SUCCESS (0.000s)
[392.852169] [070/129] (685s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[392.975725] Starting subtest: 2x-cursor-vs-flip-legacy
[392.979564] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[393.069980] [071/129] (684s left) gem_wait (write-busy)
[393.142050] Starting subtest: write-busy
[393.144462] Starting dynamic subtest: all-engines
[393.768323] Dynamic subtest all-engines: SUCCESS (0.625s)
[393.784964] Starting dynamic subtest: rcs0
[394.320098] Dynamic subtest rcs0: SUCCESS (0.550s)
[394.335021] Starting dynamic subtest: bcs0
[394.866816] Dynamic subtest bcs0: SUCCESS (0.546s)
[394.881519] Starting dynamic subtest: vcs0
[395.979054] Dynamic subtest vcs0: SUCCESS (1.110s)
[395.994240] Starting dynamic subtest: vcs1
[397.960990] Dynamic subtest vcs1: SUCCESS (1.980s)
[397.977694] Starting dynamic subtest: vecs0
[399.944968] Dynamic subtest vecs0: SUCCESS (1.982s)
[399.961513] Starting dynamic subtest: ccs0
[400.494913] Dynamic subtest ccs0: SUCCESS (0.549s)
[400.497454] Subtest write-busy: SUCCESS (7.352s)
[400.694130] [072/129] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[400.803199] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[400.807649] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[400.907664] [073/129] (677s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[401.013591] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[401.015847] Starting dynamic subtest: pipe-A
[401.540950] Dynamic subtest pipe-A: SUCCESS (0.527s)
[401.550769] Starting dynamic subtest: pipe-B
[403.126975] Dynamic subtest pipe-B: SUCCESS (1.585s)
[403.137544] Starting dynamic subtest: pipe-C
[404.730189] Dynamic subtest pipe-C: SUCCESS (1.602s)
[404.741238] Starting dynamic subtest: pipe-D
[406.320350] Dynamic subtest pipe-D: SUCCESS (1.589s)
[406.322942] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (5.306s)
[407.498953] [074/129] (670s left) gem_softpin (evict-active-interruptible)
[407.565788] Starting subtest: evict-active-interruptible
[407.573004] Subtest evict-active-interruptible: SUCCESS (0.007s)
[407.700963] [075/129] (670s left) kms_rotation_crc (cursor-rotation-180)
[407.798698] Starting subtest: cursor-rotation-180
[409.213393] Subtest cursor-rotation-180: SUCCESS (1.412s)
[410.398481] [076/129] (667s left) kms_content_protection (type1)
[410.573887] Starting subtest: type1
[413.853025] Subtest type1: SKIP (3.277s)
[414.993635] [077/129] (663s left) kms_psr (psr2-sprite-plane-onoff)
[415.092427] Starting subtest: psr2-sprite-plane-onoff
[415.094744] Starting dynamic subtest: eDP-1
[416.866156] Dynamic subtest eDP-1: SUCCESS (1.775s)
[416.868406] Subtest psr2-sprite-plane-onoff: SUCCESS (1.776s)
[417.708572] [078/129] (660s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[417.769313] Starting subtest: y-tiled-to-vebox-x-tiled
[417.773805] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[417.948324] [079/129] (660s left) kms_lease (lease-uevent)
[418.050744] Starting subtest: lease-uevent
[419.072346] Subtest lease-uevent: SUCCESS (1.020s)
[419.162783] [080/129] (659s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[419.266058] Starting subtest: fbcpsr-tiling-linear
[423.736825] Subtest fbcpsr-tiling-linear: SUCCESS (4.472s)
[423.889517] [081/129] (654s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[423.951969] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[424.053013] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[424.128371] [082/129] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[424.225657] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[424.229944] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[424.331820] [083/129] (654s left) gem_exec_fence (basic-busy-all)
[424.398158] Starting subtest: basic-busy-all
[424.493330] Subtest basic-busy-all: SUCCESS (0.095s)
[426.104157] [084/129] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[426.206177] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[426.210874] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[426.317751] [085/129] (652s left) kms_flip (2x-flip-vs-panning)
[426.414481] Starting subtest: 2x-flip-vs-panning
[426.425653] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[426.504824] [086/129] (652s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[426.598182] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[431.222469] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.628s)
[431.341058] [087/129] (647s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[431.450681] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[432.562942] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s)
[432.746441] [088/129] (645s left) gem_mmap_wc (write-read-distinct)
[432.817295] Subtest write-read-distinct: SKIP (0.000s)
[432.876774] [089/129] (645s left) drm_fdinfo (virtual-busy-hang-all)
[432.920293] Starting subtest: virtual-busy-hang-all
[432.924842] Subtest virtual-busy-hang-all: SKIP (0.000s)
[432.980940] [090/129] (645s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[433.081716] Starting subtest: 4-tiled-addfb-size-offset-overflow
[433.083956] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[433.168747] [091/129] (645s left) prime_mmap (test_refcounting)
[433.228769] Starting subtest: test_refcounting
[433.231053] Starting dynamic subtest: test_refcounting-smem
[433.258778] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[433.261367] Subtest test_refcounting: SUCCESS (0.034s)
[433.350344] [092/129] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[433.443583] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[433.447982] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[433.543690] [093/129] (645s left) kms_async_flips (async-flip-with-page-flip-events-atomic)
[433.644406] Starting subtest: async-flip-with-page-flip-events-atomic
[434.003426] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[434.753424] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.748s)
[434.762750] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[436.997124] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.245s)
[437.007319] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[437.250088] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.251s)
[437.258702] Starting dynamic subtest: pipe-A-eDP-1-4
[439.542451] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.292s)
[439.552408] Starting dynamic subtest: pipe-A-eDP-1-x
[441.853653] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.311s)
[441.866150] Starting dynamic subtest: pipe-A-eDP-1-linear
[444.154421] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.299s)
[444.532109] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[445.255942] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.731s)
[445.265795] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[447.523801] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.268s)
[447.535475] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[447.799591] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.272s)
[447.808490] Starting dynamic subtest: pipe-B-eDP-1-4
[450.090852] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.293s)
[450.100279] Starting dynamic subtest: pipe-B-eDP-1-x
[452.401507] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.310s)
[452.410462] Starting dynamic subtest: pipe-B-eDP-1-linear
[454.701843] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.299s)
[455.077849] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[455.855613] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.783s)
[455.864668] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[458.116610] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.256s)
[458.129035] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[458.375488] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.263s)
[458.384115] Starting dynamic subtest: pipe-C-eDP-1-4
[460.667308] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.292s)
[460.677728] Starting dynamic subtest: pipe-C-eDP-1-x
[462.956128] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.288s)
[462.967733] Starting dynamic subtest: pipe-C-eDP-1-linear
[465.246418] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.288s)
[465.606254] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[466.353651] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.753s)
[466.362787] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[468.608890] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.255s)
[468.622008] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[468.875486] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.262s)
[468.884309] Starting dynamic subtest: pipe-D-eDP-1-4
[471.165391] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.293s)
[471.180322] Starting dynamic subtest: pipe-D-eDP-1-x
[473.465008] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.298s)
[473.480670] Starting dynamic subtest: pipe-D-eDP-1-linear
[475.755170] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.288s)
[475.757928] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (42.106s)
[476.907265] [094/129] (601s left) kms_cursor_crc (cursor-random-32x10)
[477.056745] Starting subtest: cursor-random-32x10
[477.095797] Subtest cursor-random-32x10: SKIP (0.035s)
[477.361564] [095/129] (601s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[477.481452] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[478.922411] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.438s)
[479.796859] [096/129] (599s left) i915_hangman (engine-error-state-capture)
[479.867032] Starting subtest: engine-error-state-capture
[479.869452] Starting dynamic subtest: rcs0
[482.921085] Dynamic subtest rcs0: SUCCESS (3.054s)
[482.932757] Starting dynamic subtest: bcs0
[488.938067] Dynamic subtest bcs0: SUCCESS (6.015s)
[488.952892] Starting dynamic subtest: vcs0
[494.888401] Dynamic subtest vcs0: SUCCESS (5.948s)
[494.900881] Starting dynamic subtest: vcs1
[499.880395] Dynamic subtest vcs1: SUCCESS (4.989s)
[499.892427] Starting dynamic subtest: vecs0
[503.912702] Dynamic subtest vecs0: SUCCESS (4.030s)
[503.924885] Starting dynamic subtest: ccs0
[509.927998] Dynamic subtest ccs0: SUCCESS (6.014s)
[509.931160] Subtest engine-error-state-capture: SUCCESS (30.063s)
[510.074750] [097/129] (568s left) kms_cdclk (plane-scaling)
[510.169576] Starting subtest: plane-scaling
[510.172164] Starting dynamic subtest: pipe-A-eDP-1
[510.455985] Dynamic subtest pipe-A-eDP-1: SKIP (0.282s)
[510.466317] Starting dynamic subtest: pipe-B-eDP-1
[510.472520] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[510.487824] Starting dynamic subtest: pipe-C-eDP-1
[510.492128] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[510.501371] Starting dynamic subtest: pipe-D-eDP-1
[510.505652] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[510.510081] Subtest plane-scaling: SKIP (0.290s)
[511.292509] [098/129] (567s left) gem_exec_suspend (basic-s3)
[511.353209] Starting subtest: basic-S3
[511.355575] Starting dynamic subtest: smem
[532.153362] Dynamic subtest smem: SUCCESS (6.604s)
[532.156590] Subtest basic-S3: SUCCESS (6.606s)
[532.336030] [099/129] (560s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[532.435873] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[533.424876] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.989s)
[533.589799] [100/129] (559s left) gem_mmap_wc (read-write)
[533.654221] Subtest read-write: SKIP (0.000s)
[533.715874] [101/129] (559s left) gem_exec_fence (basic-busy)
[533.886425] Starting subtest: basic-busy
[533.889055] Starting dynamic subtest: rcs0
[533.968681] Dynamic subtest rcs0: SUCCESS (0.083s)
[533.979986] Starting dynamic subtest: bcs0
[534.029787] Dynamic subtest bcs0: SUCCESS (0.059s)
[534.041051] Starting dynamic subtest: vcs0
[534.088588] Dynamic subtest vcs0: SUCCESS (0.056s)
[534.099899] Starting dynamic subtest: vcs1
[534.147323] Dynamic subtest vcs1: SUCCESS (0.057s)
[534.158340] Starting dynamic subtest: vecs0
[534.205838] Dynamic subtest vecs0: SUCCESS (0.056s)
[534.215970] Starting dynamic subtest: ccs0
[534.268801] Dynamic subtest ccs0: SUCCESS (0.061s)
[534.271277] Subtest basic-busy: SUCCESS (0.384s)
[536.279463] [102/129] (557s left) api_intel_bb (object-noreloc-purge-cache-simple)
[536.340449] Starting subtest: object-noreloc-purge-cache-simple
[536.349796] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.011s)
[536.474865] [103/129] (556s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[536.573764] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[536.576263] Starting dynamic subtest: pipe-A-default-mode
[536.872970] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[536.877395] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.295s)
[537.674012] [104/129] (555s left) kms_psr (fbc-psr-primary-blt)
[537.780458] Starting subtest: fbc-psr-primary-blt
[537.782826] Starting dynamic subtest: eDP-1
[537.787217] Dynamic subtest eDP-1: SKIP (0.000s)
[537.791635] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[537.847836] [105/129] (555s left) gem_pxp (reject-modify-context-protection-off-3)
[537.983188] Starting subtest: reject-modify-context-protection-off-3
[537.985664] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[538.109068] [106/129] (555s left) drm_read (empty-block)
[538.277522] Starting subtest: empty-block
[539.276972] Subtest empty-block: SUCCESS (1.000s)
[539.404691] [107/129] (554s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[539.510662] Starting subtest: yf-tiled-8bpp-rotate-90
[539.514709] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[539.612948] [108/129] (553s left) gem_mmap_gtt (close-race)
[539.678793] Subtest close-race: SKIP (0.000s)
[539.741900] [109/129] (553s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[539.849252] Starting subtest: psr-rgb565-draw-render
[544.795372] Subtest psr-rgb565-draw-render: SUCCESS (4.947s)
[544.913771] [110/129] (548s left) api_intel_bb (blit-reloc-keep-cache)
[544.967266] Starting subtest: blit-reloc-keep-cache
[544.971452] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[545.086691] [111/129] (548s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[545.207452] Starting subtest: y-tiled-32bpp-rotate-90
[545.212034] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[545.311727] [112/129] (548s left) kms_vblank (invalid)
[545.412253] Starting subtest: invalid
[545.414657] Starting dynamic subtest: pipe-A-eDP-1
[545.844994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[545.847447] Subtest invalid: SUCCESS (0.432s)
[546.680247] [113/129] (547s left) drm_fdinfo (busy-idle-check-all)
[546.723463] Starting subtest: busy-idle-check-all
[546.725723] Starting dynamic subtest: rcs0
[546.732650] Dynamic subtest rcs0: SKIP (0.006s)
[546.741585] Starting dynamic subtest: bcs0
[546.745947] Dynamic subtest bcs0: SKIP (0.000s)
[546.754631] Starting dynamic subtest: vcs0
[546.758785] Dynamic subtest vcs0: SKIP (0.000s)
[546.767329] Starting dynamic subtest: vcs1
[546.771864] Dynamic subtest vcs1: SKIP (0.000s)
[546.780488] Starting dynamic subtest: vecs0
[546.785031] Dynamic subtest vecs0: SKIP (0.000s)
[546.793220] Starting dynamic subtest: ccs0
[546.797865] Dynamic subtest ccs0: SKIP (0.000s)
[546.802427] Subtest busy-idle-check-all: SKIP (0.011s)
[546.834139] [114/129] (546s left) kms_psr (fbc-psr2-sprite-plane-move)
[546.968511] Starting subtest: fbc-psr2-sprite-plane-move
[546.970776] Starting dynamic subtest: eDP-1
[546.974773] Dynamic subtest eDP-1: SKIP (0.000s)
[546.979319] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[547.036194] [115/129] (546s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[547.100012] Starting subtest: etime-single-wait-for-submit-unsubmitted
[547.203235] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[547.276040] [116/129] (546s left) kms_color (ctm-0-25)
[547.368629] Starting subtest: ctm-0-25
[547.370995] Starting dynamic subtest: pipe-A-eDP-1
[550.729689] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.359s)
[550.741048] Starting dynamic subtest: pipe-B-eDP-1
[554.902928] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.171s)
[554.913076] Starting dynamic subtest: pipe-C-eDP-1
[558.772447] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.867s)
[558.781628] Starting dynamic subtest: pipe-D-eDP-1
[562.659650] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.885s)
[562.662044] Subtest ctm-0-25: SUCCESS (15.284s)
[563.483873] [117/129] (530s left) gem_exec_balancer (bonded-false-hang)
[563.739355] Starting subtest: bonded-false-hang
[563.744593] Subtest bonded-false-hang: SKIP (0.000s)
[563.857736] [118/129] (530s left) kms_addfb_basic (no-handle)
[563.912976] Starting subtest: no-handle
[563.915341] Subtest no-handle: SUCCESS (0.000s)
[564.062833] [119/129] (529s left) prime_mmap (test_correct_cpu_write)
[564.123212] Starting subtest: test_correct_cpu_write
[564.125657] Starting dynamic subtest: test_correct_cpu_write-smem
[564.128060] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[564.130383] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[564.229812] [120/129] (529s left) gem_exec_reloc (basic-softpin)
[564.295794] Subtest basic-softpin: SKIP (0.000s)
[564.372747] [121/129] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[564.468968] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[564.473136] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[564.561785] [122/129] (529s left) syncobj_timeline (signal-array)
[564.613446] Starting subtest: signal-array
[564.615777] Subtest signal-array: SUCCESS (0.000s)
[564.715539] [123/129] (529s left) kms_flip (flip-vs-suspend)
[564.806627] Starting subtest: flip-vs-suspend
[564.808569] Starting dynamic subtest: A-eDP1
[614.141081] Dynamic subtest A-eDP1: SUCCESS (4.687s)
[614.155084] Starting dynamic subtest: B-eDP1
[663.138438] Dynamic subtest B-eDP1: SUCCESS (4.301s)
[663.147887] Starting dynamic subtest: C-eDP1
[712.136204] Dynamic subtest C-eDP1: SUCCESS (4.359s)
[712.146466] Starting dynamic subtest: D-eDP1
[761.115561] Dynamic subtest D-eDP1: SUCCESS (4.301s)
[761.132345] Subtest flip-vs-suspend: SUCCESS (17.658s)
[762.346336] [124/129] (510s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[762.454234] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[762.456562] Starting dynamic subtest: pipe-A-eDP-1
[762.480338] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[762.489901] Starting dynamic subtest: pipe-B-eDP-1
[762.512835] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[762.521641] Starting dynamic subtest: pipe-C-eDP-1
[762.543734] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[762.552518] Starting dynamic subtest: pipe-D-eDP-1
[762.574910] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[762.578991] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[764.652782] [125/129] (508s left) kms_plane (plane-panning-top-left)
[764.757875] Starting subtest: plane-panning-top-left
[764.760203] Starting dynamic subtest: pipe-A
[766.394966] Dynamic subtest pipe-A: SUCCESS (1.632s)
[766.404309] Starting dynamic subtest: pipe-B
[768.776989] Dynamic subtest pipe-B: SUCCESS (2.377s)
[768.779614] Subtest plane-panning-top-left: SUCCESS (4.013s)
[769.563681] [126/129] (503s left) perf (rc6-disable)
[769.643782] Starting subtest: rc6-disable
[769.833933] Subtest rc6-disable: SUCCESS (0.189s)
[769.874214] [127/129] (503s left) kms_invalid_mode (zero-hdisplay)
[769.972084] Starting subtest: zero-hdisplay
[769.974343] Starting dynamic subtest: pipe-A-eDP-1
[770.254547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[770.263559] Starting dynamic subtest: pipe-B-eDP-1
[770.265406] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[770.273685] Starting dynamic subtest: pipe-C-eDP-1
[770.275589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[770.284233] Starting dynamic subtest: pipe-D-eDP-1
[770.286390] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[770.288540] Subtest zero-hdisplay: SUCCESS (0.287s)
[771.057503] [128/129] (501s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[771.165093] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[771.169794] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[771.257840] [129/129] (501s left) gem_exec_schedule (semaphore-power)
[771.447752] Subtest semaphore-power: SKIP (0.000s)
[771.620973] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: gem_gpgpu_fill
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_persistence
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_chamelium_frames
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: sysfs_heartbeat_interval
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_plane_cursor
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_exec_store
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_create
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: prime_mmap_coherency
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_prime
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: gen9_exec_parse
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_vrr
results: parsing output: 45/ for test: gem_wait
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: prime_mmap
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: kms_chamelium_frames
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_dsc
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: gem_flink_basic
results: parsing output: 57/ for test: kms_fbcon_fbt
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_ctx_isolation
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: kms_3d
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: syncobj_eventfd
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: drm_fdinfo
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_async_flips
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: kms_cdclk
results: parsing output: 97/ for test: gem_exec_suspend
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: drm_read
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: drm_fdinfo
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: prime_mmap
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_invalid_mode
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_exec_schedule
Done.