[61.273426] Initializing watchdogs
[61.273472]   /dev/watchdog0
[61.287879] [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]
[61.292219] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.294622] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.298027] [001/132] (960s left) gem_exec_fence (syncobj-invalid-wait)
[61.774202] Starting subtest: syncobj-invalid-wait
[61.776711] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[63.016472] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[63.021090] [002/132] (958s left) kms_draw_crc (draw-method-pwrite)
[63.111925] Starting subtest: draw-method-pwrite
[63.113930] Starting dynamic subtest: xrgb8888-untiled
[63.675442] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[63.682565] Starting dynamic subtest: rgb565-untiled
[64.129934] Dynamic subtest rgb565-untiled: SUCCESS (0.455s)
[64.138324] Starting dynamic subtest: xrgb2101010-untiled
[64.662699] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[64.671205] Starting dynamic subtest: xbgr16161616f-untiled
[65.428352] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s)
[65.436493] Starting dynamic subtest: xrgb8888-xtiled
[67.403742] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.977s)
[67.413295] Starting dynamic subtest: rgb565-xtiled
[68.723886] Dynamic subtest rgb565-xtiled: SUCCESS (1.322s)
[68.731896] Starting dynamic subtest: xrgb2101010-xtiled
[70.466829] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.744s)
[70.474204] Starting dynamic subtest: xbgr16161616f-xtiled
[73.731128] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.266s)
[73.739853] Starting dynamic subtest: xrgb8888-4tiled
[74.832908] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.100s)
[74.841159] Starting dynamic subtest: rgb565-4tiled
[75.386108] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[75.393951] Starting dynamic subtest: xrgb2101010-4tiled
[76.463670] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s)
[76.471884] Starting dynamic subtest: xbgr16161616f-4tiled
[79.485219] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.021s)
[79.487534] Subtest draw-method-pwrite: SUCCESS (16.389s)
[79.581349] [003/132] (942s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[79.676214] Starting subtest: extended-pageflip-modeset-hang-oldfb
[79.678207] Starting dynamic subtest: pipe-A
[87.597438] Dynamic subtest pipe-A: SUCCESS (7.920s)
[87.606189] Starting dynamic subtest: pipe-D
[96.213773] Dynamic subtest pipe-D: SUCCESS (8.615s)
[96.216284] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.539s)
[97.066080] [004/132] (924s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[97.168391] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[97.170807] Starting dynamic subtest: pipe-A-default-mode
[98.322349] Dynamic subtest pipe-A-default-mode: SKIP (1.152s)
[98.326212] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.153s)
[98.453901] [005/132] (923s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[98.511718] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[98.621575] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[98.707691] [006/132] (923s left) kms_debugfs (display-on-read-all)
[98.788699] Starting subtest: display-on-read-all
[98.944293] Subtest display-on-read-all: SUCCESS (0.154s)
[99.068129] [007/132] (922s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[99.180284] Starting subtest: flip-vs-cursor-toggle
[108.132670] Subtest flip-vs-cursor-toggle: SUCCESS (8.952s)
[108.923957] [008/132] (913s left) gem_tiled_blits (basic)
[108.997469] Subtest basic: SKIP (0.000s)
[109.059922] [009/132] (913s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[109.179308] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[110.128927] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.950s)
[110.957254] [010/132] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[111.065639] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[117.841676] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.780s)
[117.941059] [011/132] (904s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[118.006462] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[118.010568] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[118.193238] [012/132] (904s left) gem_exec_flush (basic-wb-ro-default)
[118.265511] Starting subtest: basic-wb-ro-default
[123.715644] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[123.899964] [013/132] (898s left) kms_content_protection (legacy)
[124.042853] Starting subtest: legacy
[124.047673] Subtest legacy: SKIP (0.000s)
[124.151839] [014/132] (898s left) gem_exec_capture (capture-invisible)
[124.207945] Starting subtest: capture-invisible
[124.210319] Starting dynamic subtest: smem0
[124.214754] Dynamic subtest smem0: SKIP (0.000s)
[124.219193] Subtest capture-invisible: SKIP (0.000s)
[124.291120] [015/132] (898s left) gem_exec_suspend (basic-s4-devices)
[124.354397] Starting subtest: basic-S4-devices
[124.356809] Starting dynamic subtest: smem
[135.895964] Dynamic subtest smem: SUCCESS (11.539s)
[135.898937] Subtest basic-S4-devices: SUCCESS (11.540s)
[142.092445] [016/132] (886s left) kms_psr (fbc-pr-primary-blt)
[142.212325] Starting subtest: fbc-pr-primary-blt
[142.216573] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[142.282199] [017/132] (886s left) prime_vgem (basic-gtt)
[142.363343] Starting subtest: basic-gtt
[142.367530] Subtest basic-gtt: SKIP (0.000s)
[142.461256] [018/132] (886s left) prime_mmap (test_forked)
[142.525131] Starting subtest: test_forked
[142.527475] Starting dynamic subtest: test_forked-smem
[142.583558] Dynamic subtest test_forked-smem: SUCCESS (0.060s)
[142.586304] Subtest test_forked: SUCCESS (0.061s)
[142.680202] [019/132] (885s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[142.786756] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[143.854553] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s)
[143.989049] [020/132] (884s left) api_intel_bb (full-batch)
[144.043090] Starting subtest: full-batch
[144.049356] Subtest full-batch: SUCCESS (0.008s)
[144.174490] [021/132] (884s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[144.281378] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[144.284848] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[144.386889] [022/132] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[144.486070] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[144.489505] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[144.579542] [023/132] (884s left) kms_pipe_stress (stress-xrgb8888-untiled)
[144.686160] Starting subtest: stress-xrgb8888-untiled
[150.597756] Subtest stress-xrgb8888-untiled: SUCCESS (5.911s)
[150.647838] [024/132] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[150.746486] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[150.750038] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[150.848617] [025/132] (877s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[150.938994] Starting subtest: primary-4-tiled-reflect-x-180
[157.939575] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.001s)
[159.104518] [026/132] (869s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[159.215045] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[159.219240] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[159.297389] [027/132] (869s left) kms_chamelium_frames (hdmi-frame-dump)
[159.669353] Subtest hdmi-frame-dump: SKIP (0.000s)
[160.527126] [028/132] (868s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[160.626206] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[160.628643] Starting dynamic subtest: pipe-A-eDP-1
[161.448072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[161.457272] Starting dynamic subtest: pipe-B-eDP-1
[162.996659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s)
[163.006299] Starting dynamic subtest: pipe-C-eDP-1
[164.461647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.463s)
[164.471138] Starting dynamic subtest: pipe-D-eDP-1
[165.988552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[165.990347] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.357s)
[167.169389] [029/132] (861s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[167.277138] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[167.279247] Starting dynamic subtest: pipe-A-eDP-1
[167.301460] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.310565] Starting dynamic subtest: pipe-B-eDP-1
[167.332047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.340208] Starting dynamic subtest: pipe-C-eDP-1
[167.360604] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.368765] Starting dynamic subtest: pipe-D-eDP-1
[167.390091] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.394415] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.013s)
[169.558476] [030/132] (859s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[169.656341] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[169.658599] Starting dynamic subtest: pipe-A-eDP-1
[169.681363] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.692293] Starting dynamic subtest: pipe-B-eDP-1
[169.713088] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.721197] Starting dynamic subtest: pipe-C-eDP-1
[169.742142] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.750589] Starting dynamic subtest: pipe-D-eDP-1
[169.772350] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.776376] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[171.797347] [031/132] (857s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[171.912797] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[171.917161] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[172.013088] [032/132] (857s left) gem_exec_suspend (basic-s0)
[172.068533] Starting subtest: basic-S0
[172.070767] Starting dynamic subtest: smem
[192.945308] Dynamic subtest smem: SUCCESS (6.800s)
[192.948083] Subtest basic-S0: SUCCESS (6.803s)
[193.126332] [033/132] (835s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[193.228847] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[193.231063] Starting dynamic subtest: pipe-A-eDP-1
[193.251388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[193.262300] Starting dynamic subtest: pipe-B-eDP-1
[193.280853] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[193.291144] Starting dynamic subtest: pipe-C-eDP-1
[193.309612] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[193.317612] Starting dynamic subtest: pipe-D-eDP-1
[193.336281] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[193.338140] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[195.509668] [034/132] (833s left) api_intel_allocator (two-level-inception)
[195.564743] Starting subtest: two-level-inception
[200.908419] Subtest two-level-inception: SUCCESS (5.399s)
[201.069596] [035/132] (828s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[201.174636] Starting subtest: plane-lut1d-ctm3x4-lut1d
[201.298082] Starting dynamic subtest: pipe-A-plane-0
[201.485311] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[201.497770] Starting dynamic subtest: pipe-A-plane-1
[201.617976] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[201.627732] Starting dynamic subtest: pipe-A-plane-2
[201.761460] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[202.938323] Starting dynamic subtest: pipe-B-plane-0
[203.083264] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[203.092558] Starting dynamic subtest: pipe-B-plane-1
[203.227383] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[203.237629] Starting dynamic subtest: pipe-B-plane-2
[203.370755] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[204.568550] Starting dynamic subtest: pipe-C-plane-0
[204.727068] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[204.736150] Starting dynamic subtest: pipe-C-plane-1
[204.870904] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[204.881263] Starting dynamic subtest: pipe-C-plane-2
[205.014766] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[206.186987] Starting dynamic subtest: pipe-D-plane-0
[206.334340] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[206.344410] Starting dynamic subtest: pipe-D-plane-1
[206.500354] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[206.510433] Starting dynamic subtest: pipe-D-plane-2
[206.644505] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[206.930746] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.784s)
[207.749081] [036/132] (821s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[207.859679] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[208.959009] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.101s)
[209.091739] [037/132] (820s left) gem_exec_schedule (u-lateslice)
[209.160070] Starting subtest: u-lateslice
[209.161829] Starting dynamic subtest: rcs0
[209.172397] Dynamic subtest rcs0: SUCCESS (0.021s)
[209.182078] Starting dynamic subtest: bcs0
[209.194809] Dynamic subtest bcs0: SUCCESS (0.021s)
[209.202951] Starting dynamic subtest: vcs0
[209.213398] Dynamic subtest vcs0: SUCCESS (0.018s)
[209.222276] Starting dynamic subtest: vcs1
[209.234517] Dynamic subtest vcs1: SUCCESS (0.020s)
[209.244525] Starting dynamic subtest: vecs0
[209.252883] Dynamic subtest vecs0: SUCCESS (0.018s)
[209.262238] Starting dynamic subtest: ccs0
[209.271370] Dynamic subtest ccs0: SUCCESS (0.018s)
[209.273255] Subtest u-lateslice: SUCCESS (0.121s)
[211.081636] [038/132] (818s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[211.185100] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[215.775616] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.601s)
[216.952581] [039/132] (812s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[217.054481] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[217.056779] Starting dynamic subtest: pipe-A-eDP-1
[217.149856] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[217.160257] Starting dynamic subtest: pipe-B-eDP-1
[218.307486] Dynamic subtest pipe-B-eDP-1: SKIP (1.156s)
[218.311785] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.259s)
[219.499980] [040/132] (809s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[219.550569] Starting subtest: etime-single-wait-all-available-unsubmitted
[219.650934] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[219.729978] [041/132] (809s left) i915_drm_fdinfo (virtual-busy)
[219.776239] Starting subtest: virtual-busy
[219.780776] Subtest virtual-busy: SKIP (0.000s)
[219.840247] [042/132] (809s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[219.955869] Starting subtest: basic-flip-after-cursor-legacy
[220.881837] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.924s)
[221.726956] [043/132] (807s left) syncobj_basic (test-valid-cycle)
[221.775453] Starting subtest: test-valid-cycle
[221.777749] Subtest test-valid-cycle: SUCCESS (0.000s)
[221.883569] [044/132] (807s left) kms_cursor_crc (cursor-sliding-32x32)
[222.026245] Starting subtest: cursor-sliding-32x32
[222.068912] Subtest cursor-sliding-32x32: SKIP (0.039s)
[222.337985] [045/132] (807s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[222.440500] Starting subtest: y-tiled-64bpp-rotate-180
[222.444818] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[222.545174] [046/132] (807s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[222.644726] Starting subtest: pixel-format-linear-modifier-source-clamping
[222.670163] Starting dynamic subtest: pipe-A-plane-0
[226.448055] Dynamic subtest pipe-A-plane-0: SUCCESS (3.778s)
[226.459251] Starting dynamic subtest: pipe-A-plane-3
[228.137667] Dynamic subtest pipe-A-plane-3: SUCCESS (1.686s)
[229.202223] Starting dynamic subtest: pipe-B-plane-0
[232.719660] Dynamic subtest pipe-B-plane-0: SUCCESS (3.522s)
[232.729789] Starting dynamic subtest: pipe-B-plane-3
[234.363445] Dynamic subtest pipe-B-plane-3: SUCCESS (1.643s)
[234.677428] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.028s)
[235.495957] [047/132] (794s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[235.602813] Starting subtest: async-flip-with-page-flip-events-tiled
[235.978082] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[238.754780] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[238.764425] Starting dynamic subtest: pipe-A-eDP-1-4
[240.930010] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[240.939391] Starting dynamic subtest: pipe-A-eDP-1-4
[242.940023] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[242.948799] Starting dynamic subtest: pipe-A-eDP-1-x
[245.118992] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[245.488202] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[248.281589] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[248.291211] Starting dynamic subtest: pipe-B-eDP-1-4
[250.466435] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[250.475957] Starting dynamic subtest: pipe-B-eDP-1-4
[252.476531] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[252.486309] Starting dynamic subtest: pipe-B-eDP-1-x
[254.667087] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[255.057420] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[257.817600] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[257.829826] Starting dynamic subtest: pipe-C-eDP-1-4
[259.991248] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[260.000163] Starting dynamic subtest: pipe-C-eDP-1-4
[262.001490] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[262.012404] Starting dynamic subtest: pipe-C-eDP-1-x
[264.179010] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[264.541293] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[267.351544] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[267.363392] Starting dynamic subtest: pipe-D-eDP-1-4
[269.525252] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[269.537509] Starting dynamic subtest: pipe-D-eDP-1-4
[271.534563] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[271.544315] Starting dynamic subtest: pipe-D-eDP-1-x
[273.701551] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s)
[273.704454] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.105s)
[274.860849] [048/132] (754s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[274.963933] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[274.966338] Starting dynamic subtest: pipe-A
[275.200617] Dynamic subtest pipe-A: SUCCESS (0.240s)
[275.212979] Starting dynamic subtest: pipe-B
[276.526765] Dynamic subtest pipe-B: SUCCESS (1.325s)
[276.536029] Starting dynamic subtest: pipe-C
[277.875384] Dynamic subtest pipe-C: SUCCESS (1.348s)
[277.885076] Starting dynamic subtest: pipe-D
[279.195771] Dynamic subtest pipe-D: SUCCESS (1.319s)
[279.198087] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.238s)
[280.385954] [049/132] (749s left) kms_psr (fbc-psr2-dpms)
[280.484781] Starting subtest: fbc-psr2-dpms
[280.487153] Starting dynamic subtest: eDP-1
[280.491514] Dynamic subtest eDP-1: SKIP (0.000s)
[280.495935] Subtest fbc-psr2-dpms: SKIP (0.001s)
[280.561271] [050/132] (749s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[280.677311] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[287.575494] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.903s)
[287.722990] [051/132] (742s left) core_auth (many-magics)
[287.792151] Starting subtest: many-magics
[288.641595] Subtest many-magics: SUCCESS (0.853s)
[288.831208] [052/132] (741s left) gem_wait (busy)
[288.898804] Starting subtest: busy
[288.901181] Starting dynamic subtest: all-engines
[290.032165] Dynamic subtest all-engines: SUCCESS (1.131s)
[290.043565] Starting dynamic subtest: rcs0
[290.574882] Dynamic subtest rcs0: SUCCESS (0.541s)
[290.585810] Starting dynamic subtest: bcs0
[291.115949] Dynamic subtest bcs0: SUCCESS (0.540s)
[291.126741] Starting dynamic subtest: vcs0
[293.042357] Dynamic subtest vcs0: SUCCESS (1.922s)
[293.054224] Starting dynamic subtest: vcs1
[295.024605] Dynamic subtest vcs1: SUCCESS (1.979s)
[295.036684] Starting dynamic subtest: vecs0
[297.007690] Dynamic subtest vecs0: SUCCESS (1.980s)
[297.019627] Starting dynamic subtest: ccs0
[297.550086] Dynamic subtest ccs0: SUCCESS (0.541s)
[297.552449] Subtest busy: SUCCESS (8.648s)
[297.745322] [053/132] (732s left) kms_setmode (basic-clone-single-crtc)
[297.807668] Starting subtest: basic-clone-single-crtc
[297.814317] Subtest basic-clone-single-crtc: SKIP (0.000s)
[297.915961] [054/132] (732s left) i915_query (query-regions-garbage-items)
[297.969620] Starting subtest: query-regions-garbage-items
[297.971930] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[298.072188] [055/132] (732s left) gen9_exec_parse (bb-chained)
[298.134507] Subtest bb-chained: SKIP (0.000s)
[298.209815] [056/132] (731s left) gem_exec_reloc (basic-gtt-read-active)
[298.259936] Subtest basic-gtt-read-active: SKIP (0.000s)
[298.324122] [057/132] (731s left) kms_setmode (clone-exclusive-crtc)
[298.379304] Starting subtest: clone-exclusive-crtc
[298.385241] Subtest clone-exclusive-crtc: SKIP (0.000s)
[298.472220] [058/132] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[298.566734] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[298.570836] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.646125] [059/132] (731s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[298.734648] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[308.274672] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.538s)
[308.419559] [060/132] (721s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[308.834779] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[309.666016] [061/132] (720s left) gem_exec_reloc (basic-gtt-wc-active)
[309.724918] Subtest basic-gtt-wc-active: SKIP (0.000s)
[309.779914] [062/132] (720s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[309.828957] Starting subtest: yf-tiled-ccs-to-x-tiled
[309.833352] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[310.015353] [063/132] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[310.108081] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[310.112349] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[310.191304] [064/132] (720s left) kms_plane_lowres (tiling-x)
[310.271888] Starting subtest: tiling-x
[310.276383] Starting dynamic subtest: pipe-A-eDP-1
[310.280751] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[310.574562] Starting dynamic subtest: pipe-B-eDP-1
[310.579405] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[310.589124] Starting dynamic subtest: pipe-C-eDP-1
[310.593763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[310.602587] Starting dynamic subtest: pipe-D-eDP-1
[310.606866] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[310.611096] Subtest tiling-x: SKIP (0.299s)
[311.413802] [065/132] (719s left) syncobj_wait (invalid-reset-one-illegal-handle)
[311.462484] Starting subtest: invalid-reset-one-illegal-handle
[311.464776] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[311.561901] [066/132] (718s left) perf_pmu (most-busy-idle-check-all)
[311.598922] Starting subtest: most-busy-idle-check-all
[311.601010] Starting dynamic subtest: rcs0
[313.009194] Dynamic subtest rcs0: SUCCESS (1.408s)
[313.021922] Starting dynamic subtest: bcs0
[314.993138] Dynamic subtest bcs0: SUCCESS (1.980s)
[315.005925] Starting dynamic subtest: vcs0
[316.977188] Dynamic subtest vcs0: SUCCESS (1.980s)
[316.989598] Starting dynamic subtest: vcs1
[319.024230] Dynamic subtest vcs1: SUCCESS (2.044s)
[319.037370] Starting dynamic subtest: vecs0
[321.009136] Dynamic subtest vecs0: SUCCESS (1.982s)
[321.021508] Starting dynamic subtest: ccs0
[322.993324] Dynamic subtest ccs0: SUCCESS (1.981s)
[322.996275] Subtest most-busy-idle-check-all: SUCCESS (11.394s)
[323.118975] [067/132] (707s left) gem_exec_flush (basic-wb-set-default)
[323.188018] Starting subtest: basic-wb-set-default
[328.653850] Subtest basic-wb-set-default: SUCCESS (5.466s)
[328.848002] [068/132] (701s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[328.937660] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[328.939894] Starting dynamic subtest: pipe-A-eDP-1
[330.147662] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.212s)
[330.159677] Starting dynamic subtest: pipe-B-eDP-1
[332.424458] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.274s)
[332.436067] Starting dynamic subtest: pipe-C-eDP-1
[334.673152] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.247s)
[334.682864] Starting dynamic subtest: pipe-D-eDP-1
[337.006035] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.332s)
[337.008274] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.072s)
[338.150115] [069/132] (692s left) gen3_render_tiledx_blits
[338.284263] [070/132] (692s left) kms_vblank (ts-continuation-modeset-rpm)
[338.374674] Starting subtest: ts-continuation-modeset-rpm
[338.376510] Starting dynamic subtest: pipe-A-eDP-1
[340.937017] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.561s)
[340.952194] Starting dynamic subtest: pipe-D-eDP-1
[343.184054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.245s)
[343.186248] Subtest ts-continuation-modeset-rpm: SUCCESS (4.810s)
[344.075360] [071/132] (686s left) i915_pm_freq_api (freq-suspend)
[344.136925] Starting subtest: freq-suspend
[344.139212] Starting dynamic subtest: gt0
[360.041577] Dynamic subtest gt0: SUCCESS (1.218s)
[360.052937] Starting dynamic subtest: gt1
[376.066493] Dynamic subtest gt1: SUCCESS (1.204s)
[376.068320] Subtest freq-suspend: SUCCESS (2.425s)
[376.132160] [072/132] (654s left) gem_ctx_param (vm)
[376.197019] Starting subtest: vm
[376.239366] Subtest vm: SUCCESS (0.046s)
[376.374418] [073/132] (654s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[376.466220] Starting subtest: fbcpsr-rgb101010-draw-render
[383.078701] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.720s)
[383.207520] [074/132] (647s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[383.258663] Starting subtest: invalid-bsd1-flag-on-blt
[383.260892] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[383.368252] [075/132] (647s left) gem_exec_schedule (preempt-queue-chain)
[383.430003] Subtest preempt-queue-chain: SKIP (0.000s)
[383.744862] [076/132] (647s left) sriov_basic (enable-vfs-autoprobe-on)
[383.806892] Starting subtest: enable-vfs-autoprobe-on
[383.808853] Starting dynamic subtest: numvfs-1
[383.880575] Dynamic subtest numvfs-1: FAIL (0.014s)
[383.892098] Starting dynamic subtest: numvfs-2
[383.963640] Dynamic subtest numvfs-2: FAIL (0.003s)
[383.974383] Starting dynamic subtest: numvfs-3
[384.045863] Dynamic subtest numvfs-3: FAIL (0.003s)
[384.056838] Starting dynamic subtest: numvfs-4
[384.127883] Dynamic subtest numvfs-4: FAIL (0.003s)
[384.138798] Starting dynamic subtest: numvfs-5
[384.210581] Dynamic subtest numvfs-5: FAIL (0.003s)
[384.220806] Starting dynamic subtest: numvfs-6
[384.294414] Dynamic subtest numvfs-6: FAIL (0.003s)
[384.305574] Starting dynamic subtest: numvfs-7
[384.379369] Dynamic subtest numvfs-7: FAIL (0.004s)
[384.390711] Starting dynamic subtest: numvfs-random
[384.462795] Dynamic subtest numvfs-random: FAIL (0.003s)
[384.473299] Starting dynamic subtest: numvfs-all
[384.541609] Dynamic subtest numvfs-all: FAIL (0.515s)
[384.543513] Subtest enable-vfs-autoprobe-on: FAIL (0.560s)
[384.581817] [077/132] (646s left) gem_workarounds (reset)
[384.647138] Starting subtest: reset
[384.806359] Subtest reset: SUCCESS (0.161s)
[384.937477] [078/132] (646s left) gem_exec_params (invalid-flag)
[384.999271] Starting subtest: invalid-flag
[385.001123] Subtest invalid-flag: SUCCESS (0.000s)
[385.124057] [079/132] (646s left) i915_pm_rpm (gem-idle)
[386.642324] Starting subtest: gem-idle
[392.845462] Subtest gem-idle: SUCCESS (6.230s)
[393.177750] [080/132] (638s left) kms_cursor_crc (cursor-offscreen-64x21)
[394.576817] Starting subtest: cursor-offscreen-64x21
[394.622103] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[394.870781] [081/132] (636s left) kms_rotation_crc (primary-rotation-270)
[394.966425] Starting subtest: primary-rotation-270
[394.970927] Subtest primary-rotation-270: SKIP (0.001s)
[395.053415] [082/132] (636s left) fbdev (unaligned-write)
[395.092653] Starting subtest: unaligned-write
[395.189126] Subtest unaligned-write: SUCCESS (0.098s)
[395.258757] [083/132] (636s left) gem_eio (wait-1us)
[395.465298] Starting subtest: wait-1us
[395.839737] Subtest wait-1us: SUCCESS (0.376s)
[396.000327] [084/132] (635s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[396.064927] Starting subtest: multi-wait-for-submit-available-signaled
[396.066823] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[396.174040] [085/132] (635s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[396.210816] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[396.252053] [086/132] (635s left) gem_flink_basic (basic)
[396.303969] Starting subtest: basic
[396.305883] Subtest basic: SUCCESS (0.000s)
[396.397654] [087/132] (635s left) gem_userptr_blits (relocations)
[396.457076] Starting subtest: relocations
[396.460396] Subtest relocations: SKIP (0.000s)
[396.573599] [088/132] (634s left) kms_cursor_crc (cursor-random-64x64)
[396.752843] Starting subtest: cursor-random-64x64
[396.757420] Starting dynamic subtest: pipe-A-eDP-1
[400.076191] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.326s)
[400.107471] Starting dynamic subtest: pipe-D-eDP-1
[404.129142] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.036s)
[404.131697] Subtest cursor-random-64x64: SUCCESS (7.386s)
[404.933548] [089/132] (626s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[405.053367] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[405.832675] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[405.983920] [090/132] (625s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[406.072699] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[406.075064] Starting dynamic subtest: pipe-A
[407.189607] Dynamic subtest pipe-A: SUCCESS (1.117s)
[407.199454] Starting dynamic subtest: pipe-B
[409.406117] Dynamic subtest pipe-B: SUCCESS (2.213s)
[409.417981] Starting dynamic subtest: pipe-C
[410.562373] Dynamic subtest pipe-C: SUCCESS (1.154s)
[410.573184] Starting dynamic subtest: pipe-D
[411.773614] Dynamic subtest pipe-D: SUCCESS (1.210s)
[411.775954] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.700s)
[412.970734] [091/132] (618s left) kms_properties (plane-properties-atomic)
[413.055360] Starting subtest: plane-properties-atomic
[413.057649] Starting dynamic subtest: pipe-A-eDP-1
[413.603242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[413.613804] Starting dynamic subtest: pipe-B-eDP-1
[414.835597] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[414.845555] Starting dynamic subtest: pipe-C-eDP-1
[416.062297] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[416.073311] Starting dynamic subtest: pipe-D-eDP-1
[417.299155] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[417.301416] Subtest plane-properties-atomic: SUCCESS (4.245s)
[418.088727] [092/132] (613s left) kms_pm_rpm (package-g7)
[419.613923] Starting subtest: package-g7
[419.618557] Subtest package-g7: SKIP (0.000s)
[420.318931] [093/132] (611s left) gem_userptr_blits (unsync-unmap-cycles)
[420.389279] Subtest unsync-unmap-cycles: SKIP (0.000s)
[420.515257] [094/132] (611s left) perf (non-zero-reason)
[420.635721] Starting subtest: non-zero-reason
[420.637900] Starting dynamic subtest: 0-rcs0
[425.914092] Dynamic subtest 0-rcs0: SUCCESS (5.280s)
[425.929244] Starting dynamic subtest: 1-vecs0
[429.771417] Dynamic subtest 1-vecs0: SUCCESS (3.856s)
[429.774377] Subtest non-zero-reason: SUCCESS (9.138s)
[429.814648] [095/132] (601s left) gem_exec_params (larger-than-life-batch)
[429.882057] Starting subtest: larger-than-life-batch
[432.259591] Subtest larger-than-life-batch: SUCCESS (2.379s)
[433.558732] [096/132] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[433.702690] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[433.707076] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[433.809392] [097/132] (598s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[433.864274] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[433.919294] [098/132] (598s left) kms_lease (empty-lease)
[434.004733] Starting subtest: empty-lease
[434.007182] Starting dynamic subtest: pipe-A-eDP-1
[434.009612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[434.020781] Starting dynamic subtest: pipe-B-eDP-1
[434.022929] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[434.032413] Starting dynamic subtest: pipe-C-eDP-1
[434.034488] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[434.044058] Starting dynamic subtest: pipe-D-eDP-1
[434.046247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[434.048413] Subtest empty-lease: SUCCESS (0.009s)
[434.120081] [099/132] (597s left) gem_exec_balancer (hang)
[434.382254] Starting subtest: hang
[436.516998] Subtest hang: SUCCESS (2.139s)
[436.633442] [100/132] (595s left) kms_psr (fbc-psr-no-drrs)
[436.721271] Starting subtest: fbc-psr-no-drrs
[436.723432] Starting dynamic subtest: eDP-1
[436.727401] Dynamic subtest eDP-1: SKIP (0.000s)
[436.731418] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[436.797256] [101/132] (595s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[436.859394] Starting subtest: multi-wait-all-for-submit-available-signaled
[436.861483] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[436.968496] [102/132] (595s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[438.628099] Starting subtest: dpms-mode-unset-lpsp
[442.661112] Subtest dpms-mode-unset-lpsp: SUCCESS (4.037s)
[443.024969] [103/132] (589s left) gem_ctx_persistence (heartbeat-hang)
[443.088104] Starting subtest: heartbeat-hang
[443.092901] Subtest heartbeat-hang: SKIP (0.000s)
[443.185252] [104/132] (588s left) kms_psr (pr-sprite-plane-move)
[443.275756] Starting subtest: pr-sprite-plane-move
[443.280259] Subtest pr-sprite-plane-move: SKIP (0.000s)
[443.349020] [105/132] (588s left) kms_invalid_mode (zero-vdisplay)
[443.441602] Starting subtest: zero-vdisplay
[443.443990] Starting dynamic subtest: pipe-A-eDP-1
[443.739862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[443.751328] Starting dynamic subtest: pipe-B-eDP-1
[443.753625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[443.763869] Starting dynamic subtest: pipe-C-eDP-1
[443.765843] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[443.775763] Starting dynamic subtest: pipe-D-eDP-1
[443.778142] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[443.780616] Subtest zero-vdisplay: SUCCESS (0.306s)
[444.560361] [106/132] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[444.659258] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[451.449162] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.795s)
[451.575959] [107/132] (580s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[451.696931] Starting subtest: flip-vs-cursor-atomic
[459.134985] Subtest flip-vs-cursor-atomic: SUCCESS (7.441s)
[459.969038] [108/132] (572s left) gem_ctx_shared (q-promotion)
[460.055207] Starting subtest: Q-promotion
[460.057592] Starting dynamic subtest: rcs0
[460.179118] Dynamic subtest rcs0: SUCCESS (0.121s)
[460.194588] Starting dynamic subtest: vcs0
[460.284375] Dynamic subtest vcs0: SUCCESS (0.106s)
[460.303862] Starting dynamic subtest: vcs1
[460.373115] Dynamic subtest vcs1: SUCCESS (0.088s)
[460.390993] Starting dynamic subtest: vecs0
[460.469074] Dynamic subtest vecs0: SUCCESS (0.095s)
[460.486502] Starting dynamic subtest: ccs0
[460.563330] Dynamic subtest ccs0: SUCCESS (0.093s)
[460.566183] Subtest Q-promotion: SUCCESS (0.508s)
[461.561884] [109/132] (570s left) gem_softpin (reverse)
[461.621252] Starting subtest: reverse
[461.629975] Subtest reverse: SUCCESS (0.008s)
[461.747673] [110/132] (570s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[461.841193] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[461.845702] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[461.917054] [111/132] (570s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[462.037041] Starting subtest: cursorB-vs-flipB-legacy
[462.042380] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[462.182516] [112/132] (570s left) gem_mmap_gtt (cpuset-big-copy)
[462.244732] Subtest cpuset-big-copy: SKIP (0.000s)
[462.313744] [113/132] (570s left) syncobj_timeline (wait-any-interrupted)
[462.373401] Starting subtest: wait-any-interrupted
[462.474387] Subtest wait-any-interrupted: SUCCESS (0.101s)
[462.552588] [114/132] (570s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[462.650657] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[462.654093] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[462.749348] [115/132] (569s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[462.846578] Starting subtest: blocking-absolute-wf_vblank-interruptible
[462.850672] Starting dynamic subtest: A-eDP1
[471.516495] Dynamic subtest A-eDP1: SUCCESS (8.669s)
[471.531416] Starting dynamic subtest: B-eDP1
[480.253561] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[480.268700] Starting dynamic subtest: C-eDP1
[488.986244] Dynamic subtest C-eDP1: SUCCESS (8.728s)
[488.996833] Starting dynamic subtest: D-eDP1
[497.715689] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[497.720744] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.867s)
[498.927025] [116/132] (533s left) gem_render_linear_blits (basic)
[498.982775] Starting subtest: basic
[499.002500] Subtest basic: SUCCESS (0.021s)
[499.102502] [117/132] (533s left) gem_ctx_param (basic)
[499.156410] Starting subtest: basic
[499.158922] Subtest basic: SUCCESS (0.001s)
[499.270252] [118/132] (533s left) core_getversion (basic)
[499.310592] Starting subtest: basic
[499.314431] Subtest basic: SUCCESS (0.000s)
[499.379322] [119/132] (533s left) kms_atomic (plane-immutable-zpos)
[499.479416] Starting subtest: plane-immutable-zpos
[499.481704] Starting dynamic subtest: pipe-A-eDP-1
[500.158268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s)
[500.160653] Subtest plane-immutable-zpos: SUCCESS (0.679s)
[500.971318] [120/132] (531s left) gem_exec_reloc (basic-cpu)
[501.034073] Subtest basic-cpu: SKIP (0.000s)
[501.107018] [121/132] (531s left) gem_ppgtt (shrink-vs-evict-any)
[501.174581] Starting subtest: shrink-vs-evict-any
[506.484688] Subtest shrink-vs-evict-any: SUCCESS (5.309s)
[506.572257] [122/132] (526s left) gem_compute (compute-square)
[506.627824] Starting subtest: compute-square
[506.633079] Subtest compute-square: SUCCESS (0.008s)
[506.746623] [123/132] (526s left) gem_mmap_offset (mmap-unmap)
[506.798047] Starting subtest: mmap-unmap
[506.800076] Starting dynamic subtest: smem0
[529.405854] Dynamic subtest smem0: SUCCESS (22.611s)
[529.408413] Subtest mmap-unmap: SUCCESS (22.612s)
[529.536792] [124/132] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[529.647565] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[529.651468] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[529.749738] [125/132] (503s left) kms_psr (psr2-cursor-plane-onoff)
[529.843274] Starting subtest: psr2-cursor-plane-onoff
[529.845407] Starting dynamic subtest: eDP-1
[531.534911] Dynamic subtest eDP-1: SUCCESS (1.690s)
[531.536824] Subtest psr2-cursor-plane-onoff: SUCCESS (1.691s)
[532.335705] [126/132] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[532.438667] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[532.442652] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[532.538425] [127/132] (500s left) kms_flip_tiling (flip-change-tiling)
[532.628106] Starting subtest: flip-change-tiling
[532.630392] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[532.789098] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.162s)
[532.801572] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[532.923988] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[532.936688] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[533.057184] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[533.069326] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[533.200314] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[533.213367] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[533.344536] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[533.357539] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[533.488662] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[533.504998] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[533.622530] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[533.636305] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[533.733745] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[533.745380] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[533.868275] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[533.881450] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[534.011406] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[534.024810] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[534.155656] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[534.169540] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[534.299596] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[534.312838] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[534.433931] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[534.446801] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[534.568281] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[534.581361] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[534.678311] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[534.691280] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[534.822038] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[534.835733] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[534.966821] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[534.980643] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[535.110900] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[535.124210] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[535.244392] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[535.256752] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[535.389405] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[535.402745] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[535.533678] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[535.547599] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[535.655684] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[535.668652] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[535.810402] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.154s)
[535.826063] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[535.955006] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[535.969942] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[536.099625] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[536.112451] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[536.243423] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[536.258915] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[536.377589] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[536.390391] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[536.521460] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[536.534810] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[536.643881] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[536.655659] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[536.788741] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[536.801519] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[536.932996] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[536.946271] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[537.078198] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[537.092050] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[537.221940] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.141s)
[537.235651] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[537.365918] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[537.379171] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[537.511003] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[537.524820] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[537.644026] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.130s)
[537.697918] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[538.898210] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.208s)
[538.912026] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[539.033651] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[539.045421] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[539.165694] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[539.179198] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[539.309526] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[539.322834] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[539.452829] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[539.466374] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[539.597420] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[539.610577] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[539.731513] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[539.744178] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[539.842423] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[539.853887] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[539.976536] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[539.988323] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[540.109166] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[540.125766] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[540.253451] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[540.266408] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[540.386466] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[540.399451] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[540.520294] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[540.534165] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[540.654678] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[540.668539] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[540.764530] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[540.778693] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[540.898007] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s)
[540.911631] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[541.041623] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[541.054460] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[541.186241] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[541.200901] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[541.331039] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[541.344468] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[541.475397] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[541.490402] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[541.619986] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[541.634579] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[541.741655] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[541.755248] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[541.897141] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.153s)
[541.910835] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[542.041168] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[542.054105] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[542.185760] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[542.198813] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[542.330145] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[542.343391] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[542.474923] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[542.487959] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[542.618795] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[542.640015] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[542.741265] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[542.755267] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[542.885870] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[542.898669] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[543.030187] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[543.043324] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[543.163293] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.131s)
[543.177143] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[543.307577] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[543.322924] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[543.451841] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[543.464864] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[543.596552] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[543.609610] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[543.718801] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[543.771895] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[545.030321] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.266s)
[545.045423] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[545.152307] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[545.167687] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[545.252247] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[545.264850] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[545.363389] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[545.377172] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[545.473734] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[545.485941] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[545.584798] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[545.601992] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[545.685108] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[545.698608] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[545.785298] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[545.799100] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[545.885075] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[545.898592] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[545.984945] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[545.998194] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[546.095445] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[546.112841] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[546.206781] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[546.219749] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[546.307198] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[546.319142] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[546.407209] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[546.419572] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[546.507078] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[546.519096] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[546.618692] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[546.632305] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[546.729070] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[546.742031] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[546.840415] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[546.854236] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[546.940190] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[546.953547] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[547.040904] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[547.053021] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[547.152193] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[547.168216] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[547.262764] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.108s)
[547.275524] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[547.373284] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[547.385351] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[547.484730] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[547.508537] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[547.595204] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[547.608454] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[547.695578] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[547.708581] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[547.795142] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[547.810441] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[547.906282] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[547.918356] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[548.018026] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[548.032381] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[548.129110] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[548.142317] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[548.228378] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[548.240833] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[548.339767] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[548.353070] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[548.439510] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.098s)
[548.451929] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[548.550572] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[548.563012] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[548.662149] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[548.675897] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[548.773359] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[548.814927] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[550.054942] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.247s)
[550.067933] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[550.154530] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[550.166999] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[550.254770] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[550.268032] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[550.365833] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[550.379264] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[550.476194] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[550.489323] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[550.587687] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[550.601195] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[550.688107] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[550.704203] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[550.787927] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[550.800154] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[550.887743] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[550.899985] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[550.987793] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[551.000756] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[551.098203] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[551.110626] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[551.198137] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[551.210709] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[551.298261] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[551.313373] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[551.410258] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.108s)
[551.423252] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[551.510248] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[551.522692] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[551.609688] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[551.622523] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[551.720117] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[551.735268] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[551.831286] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[551.842768] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[551.931652] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[551.943828] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[552.043113] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[552.055685] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[552.154185] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[552.165595] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[552.265196] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[552.276273] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[552.414415] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.147s)
[552.428864] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[552.536501] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.120s)
[552.548556] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[552.659448] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.121s)
[552.672355] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[552.770077] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[552.785226] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[552.919406] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.147s)
[552.930609] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[553.030595] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[553.042606] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[553.141897] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[553.159202] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[553.291944] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.147s)
[553.304417] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[553.413646] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.120s)
[553.424305] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[553.525412] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[553.538153] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[553.635722] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[553.647653] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[553.746598] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[553.760841] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[553.858097] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[553.870657] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[553.969403] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[554.001988] Subtest flip-change-tiling: SUCCESS (21.380s)
[555.145912] [128/132] (478s left) perf_pmu (invalid-init)
[555.200127] Starting subtest: invalid-init
[555.202755] Subtest invalid-init: SUCCESS (0.000s)
[555.305879] [129/132] (477s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[555.418676] Starting subtest: yf-tiled-32bpp-rotate-0
[555.422923] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[555.528099] [130/132] (477s left) kms_vblank (query-busy)
[555.623674] Starting subtest: query-busy
[555.625563] Starting dynamic subtest: pipe-A-eDP-1
[557.507247] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[557.523662] Starting dynamic subtest: pipe-D-eDP-1
[560.119739] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[560.122031] Subtest query-busy: SUCCESS (4.500s)
[560.919748] [131/132] (472s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[561.010293] Starting subtest: primary-y-tiled-reflect-x-180
[561.083493] Subtest primary-y-tiled-reflect-x-180: SKIP (0.073s)
[561.196950] [132/132] (472s left) syncobj_timeline (wait-delayed-signal)
[561.256533] Starting subtest: wait-delayed-signal
[561.357119] Subtest wait-delayed-signal: SUCCESS (0.102s)
[561.435569] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_debugfs
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_tiled_blits
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_capture
results: parsing output: 14/ for test: gem_exec_suspend
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_pipe_stress
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_chamelium_frames
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_suspend
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_color_pipeline
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: i915_drm_fdinfo
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: syncobj_basic
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: core_auth
results: parsing output: 51/ for test: gem_wait
results: parsing output: 52/ for test: kms_setmode
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: kms_setmode
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_hpd
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_plane_lowres
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: gem_exec_flush
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gen3_render_tiledx_blits
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: i915_pm_freq_api
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: sriov_basic
results: parsing output: 76/ for test: gem_workarounds
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: gem_flink_basic
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: gem_exec_balancer
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_invalid_mode
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_ctx_shared
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_render_linear_blits
results: parsing output: 116/ for test: gem_ctx_param
results: parsing output: 117/ for test: core_getversion
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: gem_ppgtt
results: parsing output: 121/ for test: gem_compute
results: parsing output: 122/ for test: gem_mmap_offset
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip_tiling
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: syncobj_timeline
Done.