[58.523185] Initializing watchdogs
[58.523237]   /dev/watchdog0
[58.538524] [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]
[58.543493] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.545908] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.549207] [001/133] (960s left) gem_flink_basic (bad-open)
[58.635033] Starting subtest: bad-open
[58.637306] Subtest bad-open: SUCCESS (0.000s)
[58.744081] [002/133] (960s left) kms_feature_discovery (psr1)
[58.849772] Starting subtest: psr1
[58.852085] Subtest psr1: SUCCESS (0.000s)
[58.937739] [003/133] (960s left) gem_render_copy_redux (normal)
[59.004922] Starting subtest: normal
[59.285568] Subtest normal: SUCCESS (0.280s)
[59.409112] [004/133] (959s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[59.496793] Starting subtest: 2x-flip-vs-modeset-vs-hang
[59.506096] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[59.592900] [005/133] (959s left) perf_pmu (event-wait)
[59.634180] Starting subtest: event-wait
[59.636445] Starting dynamic subtest: rcs0
[59.639972] Dynamic subtest rcs0: SKIP (0.000s)
[59.643341] Subtest event-wait: SKIP (0.000s)
[59.727570] [006/133] (959s left) gem_exec_schedule (preempt-other)
[59.787833] Starting subtest: preempt-other
[59.789510] Starting dynamic subtest: rcs0
[59.856891] Dynamic subtest rcs0: SUCCESS (0.073s)
[59.873823] Starting dynamic subtest: bcs0
[59.924044] Dynamic subtest bcs0: SUCCESS (0.067s)
[59.937788] Starting dynamic subtest: vcs0
[59.990855] Dynamic subtest vcs0: SUCCESS (0.067s)
[60.003443] Starting dynamic subtest: vcs1
[60.054681] Dynamic subtest vcs1: SUCCESS (0.063s)
[60.067533] Starting dynamic subtest: vecs0
[60.120056] Dynamic subtest vecs0: SUCCESS (0.064s)
[60.131466] Starting dynamic subtest: ccs0
[60.186046] Dynamic subtest ccs0: SUCCESS (0.066s)
[60.188474] Subtest preempt-other: SUCCESS (0.402s)
[60.981847] [007/133] (958s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[61.080966] Starting subtest: pr-primary-plane-update-sf-dmg-area
[61.085346] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[61.157935] [008/133] (958s left) kms_cursor_crc (cursor-onscreen-32x32)
[61.311084] Starting subtest: cursor-onscreen-32x32
[61.364142] Subtest cursor-onscreen-32x32: SKIP (0.048s)
[61.631206] [009/133] (957s left) gem_ctx_persistence (legacy-engines-persistence)
[61.701248] Starting subtest: legacy-engines-persistence
[61.703679] Starting dynamic subtest: render
[62.489852] Dynamic subtest render: SUCCESS (0.787s)
[62.500099] Starting dynamic subtest: bsd1
[63.246811] Dynamic subtest bsd1: SUCCESS (0.755s)
[63.257585] Starting dynamic subtest: bsd2
[64.019055] Dynamic subtest bsd2: SUCCESS (0.770s)
[64.028669] Starting dynamic subtest: blt
[64.793876] Dynamic subtest blt: SUCCESS (0.772s)
[64.804536] Starting dynamic subtest: vebox
[65.542886] Dynamic subtest vebox: SUCCESS (0.747s)
[65.545415] Subtest legacy-engines-persistence: SUCCESS (3.838s)
[65.635014] [010/133] (953s left) kms_flip (basic-flip-vs-modeset)
[65.746518] Starting subtest: basic-flip-vs-modeset
[65.748985] Starting dynamic subtest: A-eDP1
[68.367852] Dynamic subtest A-eDP1: SUCCESS (2.621s)
[68.377054] Starting dynamic subtest: B-eDP1
[70.528769] Dynamic subtest B-eDP1: SUCCESS (2.158s)
[70.538831] Starting dynamic subtest: C-eDP1
[72.697400] Dynamic subtest C-eDP1: SUCCESS (2.167s)
[72.706881] Starting dynamic subtest: D-eDP1
[74.860634] Dynamic subtest D-eDP1: SUCCESS (2.163s)
[74.863204] Subtest basic-flip-vs-modeset: SUCCESS (9.115s)
[75.658578] [011/133] (943s left) gem_exec_schedule (semaphore-power)
[75.849845] Subtest semaphore-power: SKIP (0.000s)
[76.032849] [012/133] (943s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[76.136798] Starting subtest: fbcpsr-rgb565-draw-pwrite
[83.261028] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.127s)
[83.380247] [013/133] (936s left) kms_cursor_edge_walk (128x128-left-edge)
[83.486790] Starting subtest: 128x128-left-edge
[83.489122] Starting dynamic subtest: pipe-A-eDP-1
[86.957778] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[86.965624] Starting dynamic subtest: pipe-D-eDP-1
[90.077687] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[90.080031] Subtest 128x128-left-edge: SUCCESS (6.591s)
[90.869287] [014/133] (928s left) dumb_buffer (map-invalid-size)
[90.936051] Starting subtest: map-invalid-size
[90.938397] Subtest map-invalid-size: SUCCESS (0.000s)
[91.039221] [015/133] (928s left) gem_exec_whisper (basic-contexts-forked)
[91.102848] Starting subtest: basic-contexts-forked
[114.609651] Subtest basic-contexts-forked: SUCCESS (23.503s)
[114.804580] [016/133] (904s left) syncobj_wait (single-wait-all-for-submit-signaled)
[114.860800] Starting subtest: single-wait-all-for-submit-signaled
[114.863186] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[114.958824] [017/133] (904s left) gem_create (create-ext-placement-all)
[115.135346] Starting subtest: create-ext-placement-all
[115.137882] Subtest create-ext-placement-all: SUCCESS (0.000s)
[115.229357] [018/133] (904s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[115.624076] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[116.393569] [019/133] (903s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[116.492108] Starting subtest: plane-lut1d-pre-ctm3x4
[116.638271] Starting dynamic subtest: pipe-A-plane-0
[116.816147] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[116.825511] Starting dynamic subtest: pipe-A-plane-1
[116.982918] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[116.993466] Starting dynamic subtest: pipe-A-plane-2
[117.149889] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[118.318630] Starting dynamic subtest: pipe-B-plane-0
[118.490247] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[118.498871] Starting dynamic subtest: pipe-B-plane-1
[118.634624] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[118.643694] Starting dynamic subtest: pipe-B-plane-2
[118.801405] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[120.024345] Starting dynamic subtest: pipe-C-plane-0
[120.173265] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[120.182400] Starting dynamic subtest: pipe-C-plane-1
[120.317802] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[120.327077] Starting dynamic subtest: pipe-C-plane-2
[120.484470] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[121.667476] Starting dynamic subtest: pipe-D-plane-0
[121.805367] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[121.814262] Starting dynamic subtest: pipe-D-plane-1
[121.971181] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[121.980573] Starting dynamic subtest: pipe-D-plane-2
[122.137702] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[122.430202] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.939s)
[123.241286] [020/133] (896s left) kms_pm_rpm (drm-resources-equal)
[125.077776] Starting subtest: drm-resources-equal
[130.111304] Subtest drm-resources-equal: SUCCESS (5.035s)
[130.212249] [021/133] (889s left) gem_pxp (reject-modify-context-protection-on)
[130.336805] Starting subtest: reject-modify-context-protection-on
[130.339346] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[130.442672] [022/133] (889s left) perf (buffer-fill)
[130.568756] Starting subtest: buffer-fill
[130.570640] Starting dynamic subtest: 0-rcs0
[132.827050] Dynamic subtest 0-rcs0: SUCCESS (2.257s)
[132.836270] Starting dynamic subtest: 1-vecs0
[137.280848] Dynamic subtest 1-vecs0: SUCCESS (4.453s)
[137.283412] Subtest buffer-fill: SUCCESS (6.712s)
[137.327995] [023/133] (882s left) perf (rc6-disable)
[137.433321] Starting subtest: rc6-disable
[137.622439] Subtest rc6-disable: SUCCESS (0.188s)
[137.670936] [024/133] (882s left) gem_exec_reloc (basic-gtt-read-noreloc)
[137.739558] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[137.806602] [025/133] (882s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[137.858262] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[137.860669] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[137.953179] [026/133] (882s left) kms_flip (blocking-wf_vblank)
[138.048762] Starting subtest: blocking-wf_vblank
[138.051143] Starting dynamic subtest: A-eDP1
[147.009293] Dynamic subtest A-eDP1: SUCCESS (8.926s)
[147.020144] Starting dynamic subtest: B-eDP1
[155.942643] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[155.952700] Starting dynamic subtest: C-eDP1
[164.879673] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[164.889219] Starting dynamic subtest: D-eDP1
[173.770043] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[173.775007] Subtest blocking-wf_vblank: SUCCESS (35.725s)
[175.021662] [027/133] (845s left) kms_chamelium_audio (hdmi-audio)
[175.411521] Subtest hdmi-audio: SKIP (0.000s)
[176.214836] [028/133] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[176.314885] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[176.319432] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[176.406629] [029/133] (843s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[176.510366] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[176.514659] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[176.603034] [030/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[176.708985] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[176.713354] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[176.817123] [031/133] (843s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[176.872298] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[176.874798] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[176.980384] [032/133] (843s left) kms_flip (2x-flip-vs-expired-vblank)
[177.075245] Starting subtest: 2x-flip-vs-expired-vblank
[177.086553] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[177.175804] [033/133] (843s left) gen3_render_tiledx_blits
[177.292707] [034/133] (843s left) kms_plane_scaling (planes-scaler-unity-scaling)
[177.393480] Starting subtest: planes-scaler-unity-scaling
[177.395567] Starting dynamic subtest: pipe-A
[177.455283] Dynamic subtest pipe-A: SUCCESS (0.064s)
[177.465404] Starting dynamic subtest: pipe-B
[178.568236] Dynamic subtest pipe-B: SUCCESS (1.112s)
[178.578640] Starting dynamic subtest: pipe-C
[179.685063] Dynamic subtest pipe-C: SUCCESS (1.115s)
[179.695049] Starting dynamic subtest: pipe-D
[180.815179] Dynamic subtest pipe-D: SUCCESS (1.130s)
[180.817571] Subtest planes-scaler-unity-scaling: SUCCESS (3.424s)
[181.986708] [035/133] (838s left) kms_atomic_interruptible (atomic-setmode)
[182.083944] Starting subtest: atomic-setmode
[182.086726] Starting dynamic subtest: pipe-A-eDP-1
[189.008764] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.922s)
[189.011048] Subtest atomic-setmode: SUCCESS (6.923s)
[189.882238] [036/133] (830s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[189.984913] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[189.989273] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[190.054123] [037/133] (830s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[190.155554] Starting subtest: x-tiled-8bpp-rotate-180
[191.379934] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.225s)
[191.516720] [038/133] (828s left) gem_exec_fence (syncobj-repeat)
[191.994883] Starting subtest: syncobj-repeat
[192.183704] Subtest syncobj-repeat: SUCCESS (0.187s)
[193.962952] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[193.966295] [039/133] (826s left) gen7_exec_parse (oacontrol-tracking)
[194.036267] Subtest oacontrol-tracking: SKIP (0.000s)
[194.120089] [040/133] (826s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[194.211826] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[194.214141] Starting dynamic subtest: pipe-A-default-mode
[196.933355] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[196.935661] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.722s)
[197.779254] [041/133] (822s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[197.828863] Starting subtest: invalid-single-wait-unsubmitted
[197.831168] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[197.919264] [042/133] (822s left) kms_sequence (get-busy)
[198.009156] Starting subtest: get-busy
[198.011442] Starting dynamic subtest: pipe-A-eDP-1
[199.952949] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[199.962416] Starting dynamic subtest: pipe-B-eDP-1
[202.573442] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.621s)
[202.583166] Starting dynamic subtest: pipe-C-eDP-1
[205.165733] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.589s)
[205.175575] Starting dynamic subtest: pipe-D-eDP-1
[207.710309] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[207.712555] Subtest get-busy: SUCCESS (9.698s)
[208.498531] [043/133] (812s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[208.617185] Starting subtest: modeset-atomic-cursor-hotspot
[208.621563] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[208.762526] [044/133] (812s left) gem_mmap_wc (write-gtt-read-wc)
[208.827639] Subtest write-gtt-read-wc: SKIP (0.000s)
[208.886796] [045/133] (811s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[208.991058] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[209.781552] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[209.944557] [046/133] (810s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[210.046830] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[210.049626] Starting dynamic subtest: pipe-A-eDP-1
[210.059103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.071078] Starting dynamic subtest: pipe-B-eDP-1
[210.079745] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.087905] Starting dynamic subtest: pipe-C-eDP-1
[210.096325] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.104474] Starting dynamic subtest: pipe-D-eDP-1
[210.112950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.117071] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[212.283524] [047/133] (808s left) api_intel_allocator (reopen)
[212.336677] Starting subtest: reopen
[212.339076] Subtest reopen: SUCCESS (0.004s)
[212.459779] [048/133] (808s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[212.569944] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[212.572274] Starting dynamic subtest: pipe-A-eDP-1
[218.459908] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.896s)
[218.469792] Starting dynamic subtest: pipe-B-eDP-1
[225.121211] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.657s)
[225.123546] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.556s)
[225.983900] [049/133] (795s left) kms_psr (fbc-psr2-sprite-blt)
[226.083073] Starting subtest: fbc-psr2-sprite-blt
[226.085320] Starting dynamic subtest: eDP-1
[226.089522] Dynamic subtest eDP-1: SKIP (0.000s)
[226.093758] Subtest fbc-psr2-sprite-blt: SKIP (0.002s)
[226.156181] [050/133] (794s left) gem_exec_basic (basic)
[226.217524] Starting subtest: basic
[226.219732] Starting dynamic subtest: rcs0-smem
[226.221792] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[226.230583] Starting dynamic subtest: bcs0-smem
[226.232823] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[226.241036] Starting dynamic subtest: vcs0-smem
[226.242823] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[226.250763] Starting dynamic subtest: vcs1-smem
[226.252647] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[226.260599] Starting dynamic subtest: vecs0-smem
[226.262449] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[226.270048] Starting dynamic subtest: ccs0-smem
[226.271853] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[226.273636] Subtest basic: SUCCESS (0.016s)
[227.994714] [051/133] (793s left) syncobj_timeline (single-wait-all-available-signaled)
[228.053799] Starting subtest: single-wait-all-available-signaled
[228.055858] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[228.159835] [052/133] (792s left) kms_vblank (query-forked-busy-hang)
[228.266323] Starting subtest: query-forked-busy-hang
[228.268209] Starting dynamic subtest: pipe-A-eDP-1
[255.635449] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.368s)
[255.655550] Starting dynamic subtest: pipe-D-eDP-1
[270.694637] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.057s)
[270.696951] Subtest query-forked-busy-hang: SUCCESS (42.429s)
[271.530187] [053/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[271.656414] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[271.660943] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[271.767240] [054/133] (749s left) kms_plane_alpha_blend (constant-alpha-min)
[271.866181] Starting subtest: constant-alpha-min
[272.166154] Starting dynamic subtest: pipe-A-eDP-1
[272.872540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[272.881559] Starting dynamic subtest: pipe-D-eDP-1
[274.311084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[274.313567] Subtest constant-alpha-min: SUCCESS (2.444s)
[275.127396] [055/133] (746s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[275.241128] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[275.242957] Starting dynamic subtest: pipe-A-eDP-1
[275.387779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[275.398309] Starting dynamic subtest: pipe-B-eDP-1
[275.417597] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[275.426107] Starting dynamic subtest: pipe-C-eDP-1
[275.444394] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[275.452588] Starting dynamic subtest: pipe-D-eDP-1
[275.471532] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[275.473635] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.150s)
[277.672869] [056/133] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[277.769980] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[277.774190] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[277.861720] [057/133] (743s left) gem_ctx_shared (exec-single-timeline)
[277.925436] Starting subtest: exec-single-timeline
[277.927759] Starting dynamic subtest: rcs0
[278.963822] Dynamic subtest rcs0: SUCCESS (1.036s)
[278.973387] Starting dynamic subtest: bcs0
[280.051302] Dynamic subtest bcs0: SUCCESS (1.084s)
[280.061734] Starting dynamic subtest: vcs0
[281.140171] Dynamic subtest vcs0: SUCCESS (1.086s)
[281.155349] Starting dynamic subtest: vcs1
[282.227531] Dynamic subtest vcs1: SUCCESS (1.084s)
[282.238768] Starting dynamic subtest: vecs0
[283.315744] Dynamic subtest vecs0: SUCCESS (1.084s)
[283.327514] Starting dynamic subtest: ccs0
[284.403545] Dynamic subtest ccs0: SUCCESS (1.084s)
[284.406187] Subtest exec-single-timeline: SUCCESS (6.478s)
[284.594686] [058/133] (736s left) i915_pm_rc6_residency (rc6-fence)
[284.666172] Starting subtest: rc6-fence
[284.692927] Starting dynamic subtest: gt0
[297.025167] Dynamic subtest gt0: SUCCESS (12.317s)
[297.036096] Starting dynamic subtest: gt1
[311.894778] Dynamic subtest gt1: SUCCESS (14.879s)
[311.897402] Subtest rc6-fence: SUCCESS (27.229s)
[311.976860] [059/133] (709s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[312.084678] Starting subtest: yf-tiled-64bpp-rotate-270
[312.089066] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[312.176078] [060/133] (709s left) gem_ctx_param (invalid-param-set)
[312.241946] Starting subtest: invalid-param-set
[312.244363] Subtest invalid-param-set: SUCCESS (0.000s)
[312.333388] [061/133] (709s left) kms_getfb (getfb2-into-addfb2)
[312.421865] Starting subtest: getfb2-into-addfb2
[312.424157] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[312.522915] [062/133] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[312.623528] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[317.069753] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.449s)
[318.284169] [063/133] (703s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[318.392162] Starting subtest: sprite-rotation-90-pos-100-0
[318.396747] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[318.476080] [064/133] (703s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[318.543604] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[318.545685] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[318.653937] [065/133] (703s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[318.750336] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[318.776858] Starting dynamic subtest: pipe-A-plane-0
[319.066321] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[319.076115] Starting dynamic subtest: pipe-A-plane-3
[319.298652] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[320.364041] Starting dynamic subtest: pipe-B-plane-0
[320.656806] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[320.666399] Starting dynamic subtest: pipe-B-plane-3
[320.890545] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[321.201437] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.450s)
[322.047541] [066/133] (699s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[322.144258] Starting subtest: 4-tiled-32bpp-rotate-270
[322.164694] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[322.273163] [067/133] (699s left) kms_psr (psr-primary-mmap-gtt)
[322.360298] Starting subtest: psr-primary-mmap-gtt
[322.362481] Starting dynamic subtest: eDP-1
[323.842231] Dynamic subtest eDP-1: SKIP (1.479s)
[323.847049] Subtest psr-primary-mmap-gtt: SKIP (1.481s)
[323.999154] [068/133] (697s left) gem_ctx_param (invalid-get-no-zeromap)
[324.062900] Starting subtest: invalid-get-no-zeromap
[324.070443] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[324.174434] [069/133] (697s left) gem_bad_reloc (negative-reloc-lut)
[324.230749] Subtest negative-reloc-lut: SKIP (0.000s)
[324.320732] [070/133] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[324.426738] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[324.431158] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[324.523502] [071/133] (697s left) kms_joiner (invalid-modeset-big-joiner)
[324.617766] Starting subtest: invalid-modeset-big-joiner
[324.622178] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[324.687097] [072/133] (697s left) kms_lease (possible-crtcs-filtering)
[324.772956] Starting subtest: possible-crtcs-filtering
[324.777395] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[324.878283] [073/133] (697s left) i915_module_load (resize-bar)
[324.916212] Starting subtest: resize-bar
[324.923738] Subtest resize-bar: SKIP (0.006s)
[324.963240] [074/133] (697s left) sysfs_heartbeat_interval (mixed)
[325.020600] Starting subtest: mixed
[325.022728] Starting dynamic subtest: vecs0
[330.219176] Dynamic subtest vecs0: SUCCESS (5.197s)
[330.228868] Starting dynamic subtest: ccs0
[335.416952] Dynamic subtest ccs0: SUCCESS (5.196s)
[335.429977] Starting dynamic subtest: vcs0
[340.646533] Dynamic subtest vcs0: SUCCESS (5.227s)
[340.657801] Starting dynamic subtest: bcs0
[345.832736] Dynamic subtest bcs0: SUCCESS (5.184s)
[345.843425] Starting dynamic subtest: rcs0
[351.016140] Dynamic subtest rcs0: SUCCESS (5.183s)
[351.026332] Starting dynamic subtest: vcs1
[356.216188] Dynamic subtest vcs1: SUCCESS (5.198s)
[356.218645] Subtest mixed: SUCCESS (31.195s)
[356.305604] [075/133] (665s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[356.559317] Starting subtest: cursor-rapid-movement-256x256
[356.561476] Starting dynamic subtest: pipe-A-eDP-1
[357.095416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[357.128275] Starting dynamic subtest: pipe-D-eDP-1
[358.280516] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[358.282894] Subtest cursor-rapid-movement-256x256: SUCCESS (1.721s)
[359.139274] [076/133] (663s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[359.250253] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[366.138735] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.891s)
[366.239693] [077/133] (655s left) gem_exec_reloc (basic-gtt-read-active)
[366.298782] Subtest basic-gtt-read-active: SKIP (0.000s)
[366.372925] [078/133] (655s left) gem_exec_params (secure-non-master)
[366.421500] Starting subtest: secure-non-master
[366.425928] Subtest secure-non-master: SKIP (0.000s)
[366.532435] [079/133] (655s left) kms_psr (pr-basic)
[366.623151] Starting subtest: pr-basic
[366.627617] Subtest pr-basic: SKIP (0.000s)
[366.697558] [080/133] (655s left) gem_exec_parallel (basic)
[366.762362] Starting subtest: basic
[366.764897] Starting dynamic subtest: rcs0
[368.177049] Dynamic subtest rcs0: SUCCESS (1.414s)
[368.188672] Starting dynamic subtest: bcs0
[369.662359] Dynamic subtest bcs0: SUCCESS (1.484s)
[369.674595] Starting dynamic subtest: vcs0
[372.888405] Dynamic subtest vcs0: SUCCESS (3.221s)
[372.900583] Starting dynamic subtest: vcs1
[374.870743] Dynamic subtest vcs1: SUCCESS (1.979s)
[374.882754] Starting dynamic subtest: vecs0
[376.854169] Dynamic subtest vecs0: SUCCESS (1.981s)
[376.866095] Starting dynamic subtest: ccs0
[378.342641] Dynamic subtest ccs0: SUCCESS (1.488s)
[378.345190] Subtest basic: SUCCESS (11.581s)
[378.531114] [081/133] (643s left) kms_chamelium_hpd (dp-hpd)
[378.929143] Subtest dp-hpd: SKIP (0.000s)
[379.708614] [082/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[379.805788] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[384.169832] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.368s)
[385.340424] [083/133] (637s left) gem_fenced_exec_thrash (2-spare-fences)
[385.392776] Subtest 2-spare-fences: SKIP (0.000s)
[385.472203] [084/133] (637s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[385.526064] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[385.625838] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[385.704520] [085/133] (636s left) perf (global-sseu-config)
[385.787052] Starting subtest: global-sseu-config
[385.791620] Subtest global-sseu-config: SKIP (0.000s)
[385.834904] [086/133] (636s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[385.943320] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[387.024184] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.081s)
[387.159427] [087/133] (635s left) gem_exec_parallel (userptr)
[387.217165] Starting subtest: userptr
[387.219325] Starting dynamic subtest: rcs0
[388.643299] Dynamic subtest rcs0: SUCCESS (1.425s)
[388.652336] Starting dynamic subtest: bcs0
[390.124928] Dynamic subtest bcs0: SUCCESS (1.481s)
[390.136399] Starting dynamic subtest: vcs0
[391.893829] Dynamic subtest vcs0: SUCCESS (1.765s)
[391.905497] Starting dynamic subtest: vcs1
[393.878588] Dynamic subtest vcs1: SUCCESS (1.984s)
[393.890189] Starting dynamic subtest: vecs0
[395.862309] Dynamic subtest vecs0: SUCCESS (1.981s)
[395.871873] Starting dynamic subtest: ccs0
[397.369517] Dynamic subtest ccs0: SUCCESS (1.505s)
[397.371936] Subtest userptr: SUCCESS (10.152s)
[397.556936] [088/133] (625s left) gem_wait (invalid-flags)
[397.629740] Starting subtest: invalid-flags
[397.632139] Subtest invalid-flags: SUCCESS (0.000s)
[397.836147] [089/133] (624s left) prime_busy (hang-wait)
[397.892856] Starting subtest: hang-wait
[397.895145] Starting dynamic subtest: rcs0
[424.443372] Dynamic subtest rcs0: SUCCESS (26.538s)
[424.453551] Starting dynamic subtest: bcs0
[431.528519] Dynamic subtest bcs0: SUCCESS (7.092s)
[431.538269] Starting dynamic subtest: vcs0
[438.568052] Dynamic subtest vcs0: SUCCESS (7.039s)
[438.579335] Starting dynamic subtest: vcs1
[445.541048] Dynamic subtest vcs1: SUCCESS (6.971s)
[445.551713] Starting dynamic subtest: vecs0
[452.579913] Dynamic subtest vecs0: SUCCESS (7.035s)
[452.590332] Starting dynamic subtest: ccs0
[466.356507] Dynamic subtest ccs0: SUCCESS (13.775s)
[466.359072] Subtest hang-wait: SUCCESS (68.464s)
[466.489444] [090/133] (556s left) api_intel_bb (reset-bb)
[466.546304] Starting subtest: reset-bb
[466.550925] Subtest reset-bb: SUCCESS (0.007s)
[466.680366] [091/133] (556s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[466.776142] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[466.780337] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[466.850569] [092/133] (555s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[468.992046] Starting subtest: modeset-non-lpsp-stress-no-wait
[469.040686] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.049s)
[469.367977] [093/133] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[469.467195] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[473.922785] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.459s)
[475.091048] [094/133] (547s left) perf (polling)
[475.180840] Starting subtest: polling
[475.183066] Starting dynamic subtest: 0-rcs0
[485.254940] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[485.266262] Starting dynamic subtest: 1-vecs0
[495.275662] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[495.278197] Subtest polling: SUCCESS (20.045s)
[495.317927] [095/133] (527s left) syncobj_eventfd (invalid-illegal-eventfd)
[495.370819] Starting subtest: invalid-illegal-eventfd
[495.372896] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[495.487558] [096/133] (527s left) gem_ctx_bad_destroy (invalid-default-ctx)
[495.531845] Starting subtest: invalid-default-ctx
[495.534211] Subtest invalid-default-ctx: SUCCESS (0.000s)
[495.619690] [097/133] (527s left) gem_mmap_gtt (close-race)
[495.677163] Subtest close-race: SKIP (0.000s)
[495.737432] [098/133] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[495.832628] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[495.837069] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[495.926324] [099/133] (527s left) kms_addfb_basic (master-rmfb)
[495.987042] Starting subtest: master-rmfb
[495.989518] Subtest master-rmfb: SUCCESS (0.001s)
[496.118261] [100/133] (527s left) kms_psr (psr2-sprite-mmap-cpu)
[496.209300] Starting subtest: psr2-sprite-mmap-cpu
[496.211607] Starting dynamic subtest: eDP-1
[497.950492] Dynamic subtest eDP-1: SUCCESS (1.741s)
[497.952837] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.742s)
[498.811607] [101/133] (524s left) gem_wait (write-wait)
[498.872712] Starting subtest: write-wait
[498.875106] Starting dynamic subtest: all-engines
[499.976543] Dynamic subtest all-engines: SUCCESS (1.107s)
[499.994342] Starting dynamic subtest: rcs0
[501.037770] Dynamic subtest rcs0: SUCCESS (1.060s)
[501.055444] Starting dynamic subtest: bcs0
[502.098429] Dynamic subtest bcs0: SUCCESS (1.057s)
[502.116509] Starting dynamic subtest: vcs0
[503.152752] Dynamic subtest vcs0: SUCCESS (1.054s)
[503.169370] Starting dynamic subtest: vcs1
[504.208221] Dynamic subtest vcs1: SUCCESS (1.053s)
[504.224919] Starting dynamic subtest: vecs0
[505.263202] Dynamic subtest vecs0: SUCCESS (1.052s)
[505.279630] Starting dynamic subtest: ccs0
[506.321718] Dynamic subtest ccs0: SUCCESS (1.056s)
[506.324418] Subtest write-wait: SUCCESS (7.453s)
[506.538862] [102/133] (516s left) gem_eio (in-flight-contexts-10ms)
[506.744200] Starting subtest: in-flight-contexts-10ms
[519.922677] Subtest in-flight-contexts-10ms: SUCCESS (13.178s)
[520.096769] [103/133] (503s left) gem_softpin (allocator-nopin-reserve)
[520.160355] Starting subtest: allocator-nopin-reserve
[520.257450] Subtest allocator-nopin-reserve: SUCCESS (0.096s)
[520.396544] [104/133] (502s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[520.489606] Starting subtest: y-tiled-8bpp-rotate-270
[520.493593] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[520.576384] [105/133] (502s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[520.676095] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[520.680222] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[520.750016] [106/133] (502s left) kms_properties (plane-properties-legacy)
[520.843899] Starting subtest: plane-properties-legacy
[520.846088] Starting dynamic subtest: pipe-A-eDP-1
[521.408146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[521.418328] Starting dynamic subtest: pipe-B-eDP-1
[522.670956] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[522.681438] Starting dynamic subtest: pipe-C-eDP-1
[523.901080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[523.914217] Starting dynamic subtest: pipe-D-eDP-1
[525.136135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[525.138575] Subtest plane-properties-legacy: SUCCESS (4.294s)
[525.948538] [107/133] (497s left) gem_mmap_wc (bad-object)
[526.006575] Subtest bad-object: SKIP (0.000s)
[526.067631] [108/133] (497s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[526.155149] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[526.159121] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[526.264864] [109/133] (497s left) gem_exec_balancer (noheartbeat)
[526.521622] Starting subtest: noheartbeat
[526.526698] Subtest noheartbeat: SKIP (0.000s)
[526.631423] [110/133] (496s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[526.724558] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[526.728862] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.820310] [111/133] (496s left) kms_atomic (plane-invalid-params-fence)
[526.913199] Starting subtest: plane-invalid-params-fence
[526.915447] Starting dynamic subtest: pipe-A-eDP-1
[527.269461] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[527.271666] Subtest plane-invalid-params-fence: SUCCESS (0.357s)
[528.069303] [112/133] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[528.165681] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[528.170305] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[528.259393] [113/133] (495s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[528.363853] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[528.368100] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[528.463837] [114/133] (495s left) gem_eio (hibernate)
[528.675019] Starting subtest: hibernate
[544.316066] Subtest hibernate: SUCCESS (15.640s)
[553.501603] [115/133] (479s left) kms_psr (fbc-psr2-sprite-plane-move)
[553.628959] Starting subtest: fbc-psr2-sprite-plane-move
[553.631199] Starting dynamic subtest: eDP-1
[553.635260] Dynamic subtest eDP-1: SKIP (0.000s)
[553.639526] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[553.703273] [116/133] (479s left) sw_sync (timeline_closed_signaled)
[553.743450] Starting subtest: timeline_closed_signaled
[553.745487] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[553.795444] [117/133] (479s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[553.851932] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[553.917341] [118/133] (479s left) gem_exec_whisper (basic-queues-all)
[553.985681] Starting subtest: basic-queues-all
[564.940221] Subtest basic-queues-all: SUCCESS (10.951s)
[565.137145] [119/133] (467s left) perf (blocking)
[565.260183] Starting subtest: blocking
[565.262579] Starting dynamic subtest: 0-rcs0
[575.342705] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[575.356041] Starting dynamic subtest: 1-vecs0
[585.366615] Dynamic subtest 1-vecs0: SUCCESS (10.022s)
[585.368729] Subtest blocking: SUCCESS (20.054s)
[585.409836] [120/133] (447s left) i915_suspend (basic-s3-without-i915)
[585.458914] Starting subtest: basic-s3-without-i915
[587.192407] Subtest basic-s3-without-i915: SKIP (1.730s)
[588.775864] [121/133] (444s left) kms_content_protection (lic-type-0)
[588.936927] Starting subtest: lic-type-0
[588.941312] Subtest lic-type-0: SKIP (0.000s)
[589.067939] [122/133] (444s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[589.169746] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[589.174449] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[590.290485] [123/133] (442s left) syncobj_wait (wait-all-for-submit-complex)
[590.354353] Starting subtest: wait-all-for-submit-complex
[590.570290] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[590.647087] [124/133] (442s left) gem_eio (in-flight-internal-immediate)
[590.789996] Starting subtest: in-flight-internal-immediate
[591.927822] Subtest in-flight-internal-immediate: SUCCESS (1.138s)
[592.088833] [125/133] (441s left) kms_plane (plane-position-hole-dpms)
[592.190529] Starting subtest: plane-position-hole-dpms
[592.717862] Starting dynamic subtest: pipe-A-plane-1
[595.077120] Dynamic subtest pipe-A-plane-1: SUCCESS (2.361s)
[595.086728] Starting dynamic subtest: pipe-A-plane-2
[597.437865] Dynamic subtest pipe-A-plane-2: SUCCESS (2.359s)
[597.447920] Starting dynamic subtest: pipe-A-plane-3
[599.812726] Dynamic subtest pipe-A-plane-3: SUCCESS (2.373s)
[599.823379] Starting dynamic subtest: pipe-A-plane-4
[602.168422] Dynamic subtest pipe-A-plane-4: SUCCESS (2.356s)
[602.178964] Starting dynamic subtest: pipe-A-plane-5
[602.194557] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[603.343521] Starting dynamic subtest: pipe-B-plane-1
[605.779969] Dynamic subtest pipe-B-plane-1: SUCCESS (2.444s)
[605.790324] Starting dynamic subtest: pipe-B-plane-2
[608.208681] Dynamic subtest pipe-B-plane-2: SUCCESS (2.428s)
[608.219031] Starting dynamic subtest: pipe-B-plane-3
[610.562230] Dynamic subtest pipe-B-plane-3: SUCCESS (2.352s)
[610.572434] Starting dynamic subtest: pipe-B-plane-4
[612.961500] Dynamic subtest pipe-B-plane-4: SUCCESS (2.399s)
[612.971523] Starting dynamic subtest: pipe-B-plane-5
[612.985643] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[612.987954] Subtest plane-position-hole-dpms: SUCCESS (20.796s)
[613.761321] [126/133] (419s left) kms_addfb_basic (tile-pitch-mismatch)
[613.814996] Starting subtest: tile-pitch-mismatch
[613.819419] Subtest tile-pitch-mismatch: SKIP (0.000s)
[613.958197] [127/133] (419s left) gem_mmap_offset (isolation)
[614.010250] Starting subtest: isolation
[614.027391] Subtest isolation: SUCCESS (0.006s)
[614.118440] [128/133] (419s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[614.205489] Starting subtest: crc-primary-basic-yf-tiled-ccs
[614.207742] Starting dynamic subtest: pipe-A-eDP-1
[614.230371] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[614.242767] Starting dynamic subtest: pipe-B-eDP-1
[614.263989] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[614.273391] Starting dynamic subtest: pipe-C-eDP-1
[614.295205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[614.304071] Starting dynamic subtest: pipe-D-eDP-1
[614.325817] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[614.330172] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[616.517558] [129/133] (416s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[616.575428] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[616.580139] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[616.772322] [130/133] (416s left) gem_exec_reloc (basic-write-cpu-noreloc)
[616.834357] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[616.912450] [131/133] (416s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[616.973311] Subtest untiled-to-tiled: SKIP (0.000s)
[617.045321] [132/133] (416s left) i915_drm_fdinfo (all-busy-idle-check-all)
[617.084371] Starting subtest: all-busy-idle-check-all
[617.088972] Subtest all-busy-idle-check-all: SKIP (0.004s)
[617.167182] [133/133] (416s left) i915_query (query-garbage)
[617.237877] Starting subtest: query-garbage
[617.240305] Subtest query-garbage: SUCCESS (0.000s)
[617.350837] Closing watchdogs
results: parsing output: 0/ for test: gem_flink_basic
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: gem_render_copy_redux
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: dumb_buffer
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_create
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_chamelium_audio
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gen3_render_tiledx_blits
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_atomic_interruptible
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_sequence
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_exec_basic
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_alpha_blend
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_shared
results: parsing output: 57/ for test: i915_pm_rc6_residency
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: kms_getfb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_rotation_crc
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_ctx_param
results: parsing output: 68/ for test: gem_bad_reloc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_joiner
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: i915_module_load
results: parsing output: 73/ for test: sysfs_heartbeat_interval
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_exec_parallel
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_fenced_exec_thrash
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_parallel
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: prime_busy
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: gem_ctx_bad_destroy
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_wait
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_properties
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_atomic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: sw_sync
results: parsing output: 116/ for test: kms_pipe_b_c_ivb
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: i915_suspend
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_set_tiling_vs_blt
results: parsing output: 131/ for test: i915_drm_fdinfo
results: parsing output: 132/ for test: i915_query
Done.