[56.490674] Initializing watchdogs
[56.490721]   /dev/watchdog0
[56.504433] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.508619] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.510963] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.514336] [001/133] (960s left) gem_ctx_create (basic-files)
[56.609365] Starting subtest: basic-files
[58.620140] Subtest basic-files: SUCCESS (2.028s)
[59.908691] [002/133] (957s left) gem_lmem_swapping (parallel-multi)
[59.956864] Subtest parallel-multi: SKIP (0.000s)
[59.993310] [003/133] (957s left) gem_lmem_swapping (parallel-random-verify-ccs)
[60.033960] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[60.071445] [004/133] (957s left) kms_content_protection (dp-mst-type-1)
[60.219964] Starting subtest: dp-mst-type-1
[60.224429] Subtest dp-mst-type-1: SKIP (0.000s)
[60.347832] [005/133] (956s left) syncobj_wait (wait-all-for-submit-snapshot)
[60.395201] Starting subtest: wait-all-for-submit-snapshot
[60.476759] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[60.546759] [006/133] (956s left) gem_mmap_wc (bad-offset)
[60.597635] Subtest bad-offset: SKIP (0.000s)
[60.658436] [007/133] (956s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[61.045693] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[61.886786] [008/133] (955s left) kms_prime (basic-modeset-hybrid)
[61.968541] Subtest basic-modeset-hybrid: SKIP (0.000s)
[62.112288] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[62.115510] [009/133] (955s left) kms_pm_backlight (fade)
[62.200692] Starting subtest: fade
[62.276048] Starting dynamic subtest: eDP-1
[64.765145] Dynamic subtest eDP-1: SUCCESS (2.499s)
[64.767404] Subtest fade: SUCCESS (2.576s)
[65.619329] [010/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[65.714488] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[73.114146] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.418s)
[73.274604] [011/133] (944s left) gem_ctx_engines (none)
[73.344827] Starting subtest: none
[73.347092] Subtest none: SUCCESS (0.001s)
[73.540695] [012/133] (943s left) gem_exec_schedule (pi-shared-iova)
[73.740553] Starting subtest: pi-shared-iova
[73.742506] Starting dynamic subtest: rcs0
[73.813341] Dynamic subtest rcs0: SUCCESS (0.075s)
[73.824567] Starting dynamic subtest: vcs0
[73.864534] Dynamic subtest vcs0: SUCCESS (0.052s)
[73.872205] Starting dynamic subtest: vcs1
[73.913767] Dynamic subtest vcs1: SUCCESS (0.048s)
[73.923061] Starting dynamic subtest: vecs0
[73.967497] Dynamic subtest vecs0: SUCCESS (0.054s)
[73.977863] Starting dynamic subtest: ccs0
[74.021706] Dynamic subtest ccs0: SUCCESS (0.055s)
[74.023979] Subtest pi-shared-iova: SUCCESS (0.285s)
[74.987554] [013/133] (942s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[75.043629] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[75.045714] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[75.136632] [014/133] (942s left) kms_scaling_modes (scaling-mode-full-aspect)
[75.225997] Starting subtest: scaling-mode-full-aspect
[75.227907] Starting dynamic subtest: pipe-A-eDP-1
[75.321150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[75.332084] Starting dynamic subtest: pipe-B-eDP-1
[76.460882] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[76.470453] Starting dynamic subtest: pipe-C-eDP-1
[77.573583] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[77.581449] Starting dynamic subtest: pipe-D-eDP-1
[78.709993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[78.712272] Subtest scaling-mode-full-aspect: SUCCESS (3.489s)
[79.867631] [015/133] (937s left) gem_exec_basic (basic)
[79.941259] Starting subtest: basic
[79.943561] Starting dynamic subtest: rcs0-smem
[79.945752] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[79.955113] Starting dynamic subtest: bcs0-smem
[79.957226] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[79.964114] Starting dynamic subtest: vcs0-smem
[79.966206] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[79.973402] Starting dynamic subtest: vcs1-smem
[79.975535] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[79.982720] Starting dynamic subtest: vecs0-smem
[79.985052] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[79.991942] Starting dynamic subtest: ccs0-smem
[79.994220] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[79.996459] Subtest basic: SUCCESS (0.009s)
[81.992928] [016/133] (935s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[82.050142] Starting subtest: single-wait-for-submit-available-submitted
[82.052502] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[82.156632] [017/133] (935s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[82.272338] Starting subtest: cursor-tearing-framebuffer-change
[82.274611] Starting dynamic subtest: pipe-A-eDP-1
[82.844208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[82.853377] Starting dynamic subtest: pipe-D-eDP-1
[84.091864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[84.094222] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.818s)
[84.934209] [018/133] (932s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[84.988832] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[84.991214] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[85.093573] [019/133] (932s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[85.198818] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[85.203083] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[85.299510] [020/133] (932s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[85.401405] Starting subtest: 4-tiled-8bpp-rotate-180
[86.603434] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.202s)
[86.702886] [021/133] (931s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[86.807125] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[87.830349] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.022s)
[87.977218] [022/133] (929s left) sw_sync (sync_multi_consumer_producer)
[88.023811] Starting subtest: sync_multi_consumer_producer
[88.342134] Subtest sync_multi_consumer_producer: SUCCESS (0.321s)
[88.402454] [023/133] (929s left) kms_chamelium_color (ctm-negative)
[88.491161] Subtest ctm-negative: SKIP (0.000s)
[88.535582] [024/133] (929s left) i915_pm_rps (reset)
[88.599336] Starting subtest: reset
[97.051425] Subtest reset: SUCCESS (8.450s)
[97.166251] [025/133] (920s left) prime_mmap (test_refcounting)
[97.221189] Starting subtest: test_refcounting
[97.223268] Starting dynamic subtest: test_refcounting-smem
[97.251876] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[97.254387] Subtest test_refcounting: SUCCESS (0.033s)
[97.388180] [026/133] (920s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[97.478850] Starting subtest: basic-max-pipe-crc-check
[97.483395] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[97.524733] [027/133] (920s left) gem_exec_parallel (userptr)
[97.584632] Starting subtest: userptr
[97.587252] Starting dynamic subtest: rcs0
[99.012343] Dynamic subtest rcs0: SUCCESS (1.428s)
[99.023142] Starting dynamic subtest: bcs0
[100.480940] Dynamic subtest bcs0: SUCCESS (1.467s)
[100.489801] Starting dynamic subtest: vcs0
[101.958451] Dynamic subtest vcs0: SUCCESS (1.475s)
[101.969454] Starting dynamic subtest: vcs1
[103.833722] Dynamic subtest vcs1: SUCCESS (1.874s)
[103.842064] Starting dynamic subtest: vecs0
[105.881608] Dynamic subtest vecs0: SUCCESS (2.045s)
[105.892550] Starting dynamic subtest: ccs0
[107.373909] Dynamic subtest ccs0: SUCCESS (1.492s)
[107.376325] Subtest userptr: SUCCESS (9.790s)
[107.560356] [028/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[107.675589] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[114.201088] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.528s)
[114.315745] [029/133] (903s left) kms_flip (2x-wf_vblank-ts-check)
[114.405812] Starting subtest: 2x-wf_vblank-ts-check
[114.415436] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[114.493635] [030/133] (903s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[114.554233] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[114.631166] [031/133] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[114.729066] Starting subtest: psr-1p-primscrn-cur-indfb-move
[122.146723] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.423s)
[122.288184] [032/133] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[122.384245] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[122.486670] [033/133] (895s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[122.579392] Starting subtest: x-tiled-16bpp-rotate-270
[122.598944] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[122.714193] [034/133] (895s left) prime_mmap (test_correct_cpu_write)
[122.765230] Starting subtest: test_correct_cpu_write
[122.767596] Starting dynamic subtest: test_correct_cpu_write-smem
[122.769970] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[122.772426] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[122.869310] [035/133] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[122.965734] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[122.969902] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[123.052611] [036/133] (895s left) kms_cursor_crc (cursor-onscreen-32x32)
[123.197530] Starting subtest: cursor-onscreen-32x32
[123.245808] Subtest cursor-onscreen-32x32: SKIP (0.043s)
[123.522646] [037/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[123.584651] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[123.588134] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[123.770594] [038/133] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[123.860408] Starting subtest: addfb25-yf-tiled-legacy
[123.862423] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[123.960006] [039/133] (894s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[124.052218] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[124.054477] Starting dynamic subtest: pipe-A-default-mode
[125.216941] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[125.221233] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.163s)
[125.361136] [040/133] (893s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[125.460161] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[125.462477] Starting dynamic subtest: pipe-A-eDP-1
[132.928049] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.472s)
[132.941229] Starting dynamic subtest: pipe-B-eDP-1
[139.998050] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.067s)
[140.000335] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.542s)
[140.837737] [041/133] (877s left) syncobj_basic (test-valid-cycle)
[140.896074] Starting subtest: test-valid-cycle
[140.897908] Subtest test-valid-cycle: SUCCESS (0.000s)
[140.991230] [042/133] (877s left) gem_spin_batch (spin-all-new)
[141.045466] Starting subtest: spin-all-new
[141.063866] Subtest spin-all-new: SUCCESS (0.018s)
[142.914987] [043/133] (875s left) syncobj_timeline (invalid-signal-zero-handles)
[142.973479] Starting subtest: invalid-signal-zero-handles
[142.975510] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[143.061843] [044/133] (875s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[143.150081] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[143.154143] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[143.219294] [045/133] (875s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[143.281657] Subtest tiled-to-untiled: SKIP (0.000s)
[143.362822] [046/133] (875s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[143.464453] Starting subtest: plane-upscale-20x20-with-rotation
[143.466772] Starting dynamic subtest: pipe-A
[143.689099] Dynamic subtest pipe-A: SUCCESS (0.227s)
[143.703558] Starting dynamic subtest: pipe-B
[145.009883] Dynamic subtest pipe-B: SUCCESS (1.320s)
[145.017684] Starting dynamic subtest: pipe-C
[146.335830] Dynamic subtest pipe-C: SUCCESS (1.325s)
[146.344193] Starting dynamic subtest: pipe-D
[147.683931] Dynamic subtest pipe-D: SUCCESS (1.346s)
[147.686162] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.223s)
[148.856243] [047/133] (869s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[148.965457] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[148.969952] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[149.070267] [048/133] (869s left) fbdev (eof)
[149.106155] Starting subtest: eof
[149.108510] Subtest eof: SUCCESS (0.000s)
[149.177721] [049/133] (869s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[149.273160] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[149.277063] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[149.339167] [050/133] (869s left) gem_exec_schedule (wide)
[149.528040] Starting subtest: wide
[149.530444] Starting dynamic subtest: rcs0
[160.390084] Dynamic subtest rcs0: SUCCESS (10.863s)
[160.400271] Starting dynamic subtest: vcs0
[171.370326] Dynamic subtest vcs0: SUCCESS (10.979s)
[171.381344] Starting dynamic subtest: vcs1
[182.818231] Dynamic subtest vcs1: SUCCESS (11.446s)
[182.829415] Starting dynamic subtest: vecs0
[193.466470] Dynamic subtest vecs0: SUCCESS (10.647s)
[193.477165] Starting dynamic subtest: ccs0
[206.645097] Dynamic subtest ccs0: SUCCESS (13.177s)
[206.647908] Subtest wide: SUCCESS (57.117s)
[208.697728] [051/133] (810s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[208.795742] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[208.797598] Starting dynamic subtest: pipe-A-eDP-1
[225.488220] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.548s)
[225.502546] Starting dynamic subtest: pipe-B-eDP-1
[242.440807] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.444s)
[242.454403] Starting dynamic subtest: pipe-C-eDP-1
[259.401473] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.378s)
[259.415628] Starting dynamic subtest: pipe-D-eDP-1
[276.407231] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.372s)
[276.409234] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.748s)
[277.622660] [052/133] (741s left) kms_cursor_crc (cursor-size-hints)
[277.744876] Starting subtest: cursor-size-hints
[277.747091] Starting dynamic subtest: pipe-A-eDP-1
[278.351099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[278.368921] Starting dynamic subtest: pipe-D-eDP-1
[279.561174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[279.563523] Subtest cursor-size-hints: SUCCESS (1.861s)
[280.351821] [053/133] (738s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[280.445753] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[280.448253] Starting dynamic subtest: pipe-A-default-mode
[283.179995] Dynamic subtest pipe-A-default-mode: SUCCESS (2.780s)
[283.182156] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.782s)
[283.998728] [054/133] (735s left) gem_mmap_gtt (pf-nonblock)
[284.050587] Subtest pf-nonblock: SKIP (0.000s)
[284.117129] [055/133] (735s left) kms_selftest (drm_damage_helper)
[284.158322] Starting subtest: drm_damage_helper
[284.188826] Starting dynamic subtest: drm_test_damage_iter_no_damage
[284.322375] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.135s)
[284.331406] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[284.417771] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.095s)
[284.426641] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[284.508904] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.091s)
[284.517561] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[284.609553] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.102s)
[284.617853] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[284.695300] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.085s)
[284.704352] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[284.792784] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.098s)
[284.801053] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[284.889867] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.096s)
[284.898234] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[284.983151] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.093s)
[284.993567] Starting dynamic subtest: drm_test_damage_iter_single_damage
[285.067384] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.082s)
[285.076444] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[285.157360] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.089s)
[285.165841] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[285.251418] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.094s)
[285.260446] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[285.350917] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.099s)
[285.360433] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[285.451576] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.100s)
[285.459795] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[285.541874] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.090s)
[285.550067] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[285.632002] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.090s)
[285.640174] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[285.740141] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.109s)
[285.749583] Starting dynamic subtest: drm_test_damage_iter_damage
[285.847607] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.107s)
[285.855871] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[285.932803] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.086s)
[285.941371] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[286.050622] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.115s)
[286.059401] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[286.154153] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.104s)
[286.164843] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[286.247862] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.093s)
[286.249961] Subtest drm_damage_helper: SUCCESS (2.115s)
[286.389298] [056/133] (732s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[286.488859] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[286.493176] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[286.582732] [057/133] (732s left) api_intel_bb (intel-bb-blit-y)
[286.628214] Starting subtest: intel-bb-blit-y
[290.289909] Subtest intel-bb-blit-y: SUCCESS (3.688s)
[290.406942] [058/133] (728s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[290.507501] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[290.509850] Starting dynamic subtest: pipe-A-eDP-1
[290.532658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.543439] Starting dynamic subtest: pipe-B-eDP-1
[290.564392] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.572781] Starting dynamic subtest: pipe-C-eDP-1
[290.593276] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.601513] Starting dynamic subtest: pipe-D-eDP-1
[290.621917] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.625925] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[292.789007] [059/133] (726s left) prime_busy (after)
[292.850033] Starting subtest: after
[292.854955] Starting dynamic subtest: rcs0
[292.894665] Dynamic subtest rcs0: SUCCESS (0.041s)
[292.908366] Starting dynamic subtest: bcs0
[292.944660] Dynamic subtest bcs0: SUCCESS (0.047s)
[292.954291] Starting dynamic subtest: vcs0
[292.984631] Dynamic subtest vcs0: SUCCESS (0.039s)
[292.993750] Starting dynamic subtest: vcs1
[293.025403] Dynamic subtest vcs1: SUCCESS (0.040s)
[293.034214] Starting dynamic subtest: vecs0
[293.066236] Dynamic subtest vecs0: SUCCESS (0.040s)
[293.075938] Starting dynamic subtest: ccs0
[293.106284] Dynamic subtest ccs0: SUCCESS (0.039s)
[293.215957] Subtest after: SUCCESS (0.365s)
[293.291739] [060/133] (726s left) gem_exec_create (forked)
[293.352003] Starting subtest: forked
[293.354241] Starting dynamic subtest: smem
[313.996406] Dynamic subtest smem: SUCCESS (20.663s)
[313.999257] Subtest forked: SUCCESS (20.666s)
[314.184647] [061/133] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[314.291826] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[321.689477] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.397s)
[321.813644] [062/133] (697s left) gem_ctx_create (basic)
[321.873952] Starting subtest: basic
[321.876398] Subtest basic: SUCCESS (0.000s)
[322.071786] [063/133] (697s left) kms_invalid_mode (clock-too-high)
[322.163824] Starting subtest: clock-too-high
[322.166203] Starting dynamic subtest: pipe-A-eDP-1
[322.170678] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.180616] Starting dynamic subtest: pipe-B-eDP-1
[322.185039] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.194201] Starting dynamic subtest: pipe-C-eDP-1
[322.198459] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.206973] Starting dynamic subtest: pipe-D-eDP-1
[322.210997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.214967] Subtest clock-too-high: SKIP (0.004s)
[322.253739] [064/133] (697s left) gem_userptr_blits (coherency-unsync)
[322.319029] Subtest coherency-unsync: SKIP (0.000s)
[322.453111] [065/133] (697s left) kms_frontbuffer_tracking (psr-2p-rte)
[322.548826] Starting subtest: psr-2p-rte
[322.553018] Subtest psr-2p-rte: SKIP (0.000s)
[322.637897] [066/133] (696s left) gem_ctx_shared (exec-single-timeline)
[322.703499] Starting subtest: exec-single-timeline
[322.705826] Starting dynamic subtest: rcs0
[323.753573] Dynamic subtest rcs0: SUCCESS (1.047s)
[323.766366] Starting dynamic subtest: bcs0
[324.840160] Dynamic subtest bcs0: SUCCESS (1.084s)
[324.852397] Starting dynamic subtest: vcs0
[325.927408] Dynamic subtest vcs0: SUCCESS (1.084s)
[325.940191] Starting dynamic subtest: vcs1
[327.015743] Dynamic subtest vcs1: SUCCESS (1.085s)
[327.028660] Starting dynamic subtest: vecs0
[328.103982] Dynamic subtest vecs0: SUCCESS (1.086s)
[328.122092] Starting dynamic subtest: ccs0
[329.191571] Dynamic subtest ccs0: SUCCESS (1.082s)
[329.194123] Subtest exec-single-timeline: SUCCESS (6.487s)
[329.985175] [067/133] (689s left) perf_pmu (most-busy-idle-check-all)
[330.025906] Starting subtest: most-busy-idle-check-all
[330.028246] Starting dynamic subtest: rcs0
[331.916027] Dynamic subtest rcs0: SUCCESS (1.889s)
[331.928649] Starting dynamic subtest: bcs0
[333.964057] Dynamic subtest bcs0: SUCCESS (2.045s)
[333.976530] Starting dynamic subtest: vcs0
[335.948035] Dynamic subtest vcs0: SUCCESS (1.980s)
[335.960380] Starting dynamic subtest: vcs1
[337.995814] Dynamic subtest vcs1: SUCCESS (2.045s)
[338.008404] Starting dynamic subtest: vecs0
[339.980448] Dynamic subtest vecs0: SUCCESS (1.981s)
[339.992444] Starting dynamic subtest: ccs0
[341.964231] Dynamic subtest ccs0: SUCCESS (1.981s)
[341.967124] Subtest most-busy-idle-check-all: SUCCESS (11.941s)
[342.076916] [068/133] (677s left) syncobj_basic (create-signaled)
[342.146439] Starting subtest: create-signaled
[342.148795] Subtest create-signaled: SUCCESS (0.000s)
[342.233998] [069/133] (677s left) api_intel_allocator (open-vm)
[342.299053] Starting subtest: open-vm
[342.302372] Subtest open-vm: SUCCESS (0.006s)
[342.432885] [070/133] (677s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[342.549956] Starting subtest: bad-pixel-format-yf-tiled-ccs
[342.552301] Starting dynamic subtest: pipe-A-eDP-1
[342.575165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[342.597031] Starting dynamic subtest: pipe-B-eDP-1
[342.618799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[342.637902] Starting dynamic subtest: pipe-C-eDP-1
[342.660268] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[342.679374] Starting dynamic subtest: pipe-D-eDP-1
[342.702990] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[342.707607] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[344.858270] [071/133] (674s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[344.953224] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[344.957450] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[345.046592] [072/133] (674s left) sw_sync (sync_busy_fork)
[345.089004] Starting subtest: sync_busy_fork
[346.099024] Subtest sync_busy_fork: SUCCESS (1.011s)
[346.169757] [073/133] (673s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[346.282614] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[353.388684] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.110s)
[353.527464] [074/133] (666s left) kms_cursor_legacy (single-bo)
[353.644681] Starting subtest: single-bo
[353.646492] Starting dynamic subtest: pipe-A
[359.025696] Dynamic subtest pipe-A: SUCCESS (5.380s)
[359.037560] Starting dynamic subtest: pipe-B
[364.408036] Dynamic subtest pipe-B: SUCCESS (5.380s)
[364.419302] Starting dynamic subtest: pipe-C
[369.788560] Dynamic subtest pipe-C: SUCCESS (5.379s)
[369.800049] Starting dynamic subtest: pipe-D
[375.172211] Dynamic subtest pipe-D: SUCCESS (5.380s)
[375.183407] Starting dynamic subtest: all-pipes
[380.564109] Dynamic subtest all-pipes: SUCCESS (5.386s)
[380.567025] Subtest single-bo: SUCCESS (26.919s)
[380.709392] [075/133] (639s left) vgem_basic (bad-pad)
[380.777825] Starting subtest: bad-pad
[380.780174] Subtest bad-pad: SUCCESS (0.000s)
[380.838128] [076/133] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[380.937849] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[380.942230] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[381.024710] [077/133] (639s left) gem_userptr_blits (huge-split)
[381.091409] Starting subtest: huge-split
[381.097868] Subtest huge-split: SUCCESS (0.006s)
[381.220251] [078/133] (638s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[381.321171] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[381.934555] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.615s)
[382.098954] [079/133] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[382.190595] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[386.455360] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.267s)
[387.589539] [080/133] (632s left) gem_exec_fence (basic-wait-all)
[387.658143] Starting subtest: basic-wait-all
[387.740695] Subtest basic-wait-all: SUCCESS (0.083s)
[390.049812] [081/133] (630s left) kms_draw_crc (draw-method-pwrite)
[390.144321] Starting subtest: draw-method-pwrite
[390.146219] Starting dynamic subtest: xrgb8888-untiled
[390.732066] Dynamic subtest xrgb8888-untiled: SUCCESS (0.589s)
[390.742298] Starting dynamic subtest: rgb565-untiled
[391.198760] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[391.208646] Starting dynamic subtest: xrgb2101010-untiled
[391.743479] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[391.754109] Starting dynamic subtest: xbgr16161616f-untiled
[392.521376] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.776s)
[392.531809] Starting dynamic subtest: xrgb8888-xtiled
[394.254759] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.732s)
[394.264819] Starting dynamic subtest: rgb565-xtiled
[395.310620] Dynamic subtest rgb565-xtiled: SUCCESS (1.055s)
[395.320737] Starting dynamic subtest: xrgb2101010-xtiled
[397.055120] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.744s)
[397.065702] Starting dynamic subtest: xbgr16161616f-xtiled
[400.300172] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.244s)
[400.310364] Starting dynamic subtest: xrgb8888-4tiled
[401.378939] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s)
[401.388707] Starting dynamic subtest: rgb565-4tiled
[401.922402] Dynamic subtest rgb565-4tiled: SUCCESS (0.542s)
[401.932534] Starting dynamic subtest: xrgb2101010-4tiled
[402.980532] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s)
[402.991758] Starting dynamic subtest: xbgr16161616f-4tiled
[405.945013] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.966s)
[405.947370] Subtest draw-method-pwrite: SUCCESS (15.801s)
[406.040903] [082/133] (614s left) gem_exec_reloc (basic-cpu-wc-active)
[406.104474] Subtest basic-cpu-wc-active: SKIP (0.000s)
[406.174813] [083/133] (614s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[406.292834] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[437.667974] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.377s)
[438.506701] [084/133] (581s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[438.890017] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[439.721859] [085/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[439.817011] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[439.821188] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[439.917561] [086/133] (580s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[440.012673] Starting subtest: fbc-pr-sprite-mmap-gtt
[440.016631] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[440.103192] [087/133] (580s left) kms_setmode (invalid-clone-exclusive-crtc)
[440.157928] Starting subtest: invalid-clone-exclusive-crtc
[440.164618] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[440.264005] [088/133] (580s left) perf_pmu (busy-double-start)
[440.301206] Starting subtest: busy-double-start
[440.303258] Starting dynamic subtest: rcs0
[443.934962] Dynamic subtest rcs0: FAIL (3.581s)
[443.945392] Starting dynamic subtest: bcs0
[447.456667] Dynamic subtest bcs0: SUCCESS (3.575s)
[447.469057] Starting dynamic subtest: vcs0
[451.466604] Dynamic subtest vcs0: SUCCESS (4.008s)
[451.484529] Starting dynamic subtest: vcs1
[455.497036] Dynamic subtest vcs1: SUCCESS (4.030s)
[455.508799] Starting dynamic subtest: vecs0
[459.495929] Dynamic subtest vecs0: SUCCESS (3.998s)
[459.508115] Starting dynamic subtest: ccs0
[463.132378] Dynamic subtest ccs0: FAIL (3.566s)
[463.134372] Subtest busy-double-start: FAIL (22.768s)
[463.177030] [089/133] (557s left) vgem_basic (second-client)
[463.235382] Starting subtest: second-client
[463.257372] Subtest second-client: SUCCESS (0.022s)
[463.320886] [090/133] (557s left) gem_exec_params (secure-non-master)
[463.381848] Starting subtest: secure-non-master
[463.386534] Subtest secure-non-master: SKIP (0.000s)
[463.526237] [091/133] (557s left) gem_exec_fence (nb-await)
[463.710259] Starting subtest: nb-await
[463.712948] Starting dynamic subtest: rcs0
[463.789659] Dynamic subtest rcs0: SUCCESS (0.079s)
[463.802286] Starting dynamic subtest: bcs0
[463.849334] Dynamic subtest bcs0: SUCCESS (0.058s)
[463.861662] Starting dynamic subtest: vcs0
[463.909705] Dynamic subtest vcs0: SUCCESS (0.058s)
[463.921964] Starting dynamic subtest: vcs1
[463.970245] Dynamic subtest vcs1: SUCCESS (0.059s)
[463.982775] Starting dynamic subtest: vecs0
[464.029961] Dynamic subtest vecs0: SUCCESS (0.058s)
[464.042395] Starting dynamic subtest: ccs0
[464.091648] Dynamic subtest ccs0: SUCCESS (0.059s)
[464.094412] Subtest nb-await: SUCCESS (0.383s)
[466.113073] [092/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[466.214656] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[466.218664] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[466.311050] [093/133] (554s left) kms_plane (plane-position-hole-dpms)
[466.413230] Starting subtest: plane-position-hole-dpms
[466.932395] Starting dynamic subtest: pipe-A-plane-1
[469.345909] Dynamic subtest pipe-A-plane-1: SUCCESS (2.413s)
[469.366745] Starting dynamic subtest: pipe-A-plane-2
[471.779288] Dynamic subtest pipe-A-plane-2: SUCCESS (2.433s)
[471.789306] Starting dynamic subtest: pipe-A-plane-3
[474.134085] Dynamic subtest pipe-A-plane-3: SUCCESS (2.353s)
[474.144634] Starting dynamic subtest: pipe-A-plane-4
[476.493936] Dynamic subtest pipe-A-plane-4: SUCCESS (2.361s)
[476.505197] Starting dynamic subtest: pipe-A-plane-5
[476.519831] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[477.674710] Starting dynamic subtest: pipe-B-plane-1
[480.087847] Dynamic subtest pipe-B-plane-1: SUCCESS (2.422s)
[480.098445] Starting dynamic subtest: pipe-B-plane-2
[482.443168] Dynamic subtest pipe-B-plane-2: SUCCESS (2.356s)
[482.453874] Starting dynamic subtest: pipe-B-plane-3
[484.807608] Dynamic subtest pipe-B-plane-3: SUCCESS (2.363s)
[484.819951] Starting dynamic subtest: pipe-B-plane-4
[487.175937] Dynamic subtest pipe-B-plane-4: SUCCESS (2.369s)
[487.186378] Starting dynamic subtest: pipe-B-plane-5
[487.201022] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[487.203311] Subtest plane-position-hole-dpms: SUCCESS (20.792s)
[487.973596] [094/133] (532s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[488.077962] Starting subtest: fbcpsr-rgb565-draw-blt
[495.109836] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.036s)
[495.249881] [095/133] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[495.342925] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[495.347154] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[495.431792] [096/133] (525s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[495.548575] Starting subtest: cursorA-vs-flipA-varying-size
[506.686907] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.136s)
[507.536859] [097/133] (513s left) dmabuf_sync_file (import-multiple-read-only)
[507.587999] Starting subtest: import-multiple-read-only
[507.590419] Subtest import-multiple-read-only: SUCCESS (0.003s)
[507.650860] [098/133] (513s left) gem_ctx_persistence (file)
[507.716953] Starting subtest: file
[507.838331] Subtest file: SUCCESS (0.121s)
[507.948784] [099/133] (513s left) kms_rotation_crc (bad-tiling)
[508.040808] Starting subtest: bad-tiling
[508.045304] Subtest bad-tiling: SKIP (0.001s)
[508.116651] [100/133] (512s left) i915_selftest (mock)
[512.745866] Starting subtest: mock
[512.747967] Starting dynamic subtest: sanitycheck
[513.420694] Dynamic subtest sanitycheck: SUCCESS (0.674s)
[513.430781] Starting dynamic subtest: shmem
[514.118544] Dynamic subtest shmem: SUCCESS (0.695s)
[514.128854] Starting dynamic subtest: fence
[522.147392] Dynamic subtest fence: SUCCESS (8.024s)
[522.157764] Starting dynamic subtest: scatterlist
[523.853123] Dynamic subtest scatterlist: SUCCESS (1.702s)
[523.863507] Starting dynamic subtest: syncmap
[527.062744] Dynamic subtest syncmap: SUCCESS (3.207s)
[527.072890] Starting dynamic subtest: uncore
[527.739550] Dynamic subtest uncore: SUCCESS (0.675s)
[527.749381] Starting dynamic subtest: ring
[528.413150] Dynamic subtest ring: SUCCESS (0.671s)
[528.422562] Starting dynamic subtest: engine
[529.091581] Dynamic subtest engine: SUCCESS (0.676s)
[529.101747] Starting dynamic subtest: timelines
[532.898569] Dynamic subtest timelines: SUCCESS (3.803s)
[532.908142] Starting dynamic subtest: requests
[537.005377] Dynamic subtest requests: SUCCESS (4.105s)
[537.014682] Starting dynamic subtest: objects
[537.784402] Dynamic subtest objects: SUCCESS (0.778s)
[537.794286] Starting dynamic subtest: phys
[538.531490] Dynamic subtest phys: SUCCESS (0.746s)
[538.540801] Starting dynamic subtest: dmabuf
[539.304517] Dynamic subtest dmabuf: SUCCESS (0.771s)
[539.313557] Starting dynamic subtest: vma
[545.031376] Dynamic subtest vma: SUCCESS (5.724s)
[545.040742] Starting dynamic subtest: evict
[546.497774] Dynamic subtest evict: SUCCESS (1.464s)
[546.508054] Starting dynamic subtest: gtt
[549.851919] Dynamic subtest gtt: SUCCESS (3.352s)
[549.861788] Starting dynamic subtest: hugepages
[550.738089] Dynamic subtest hugepages: SUCCESS (0.885s)
[550.748179] Starting dynamic subtest: memory_region
[553.358403] Dynamic subtest memory_region: SUCCESS (2.618s)
[553.361146] Subtest mock: SUCCESS (40.608s)
[553.390593] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[553.391406] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[553.394598] [101/133] (467s left) kms_async_flips (test-cursor-atomic)
[554.939166] Starting subtest: test-cursor-atomic
[555.320640] Starting dynamic subtest: pipe-A-eDP-1
[556.067473] Dynamic subtest pipe-A-eDP-1: SKIP (0.743s)
[556.455806] Starting dynamic subtest: pipe-B-eDP-1
[557.196008] Dynamic subtest pipe-B-eDP-1: SKIP (0.744s)
[557.565228] Starting dynamic subtest: pipe-C-eDP-1
[558.318965] Dynamic subtest pipe-C-eDP-1: SKIP (0.756s)
[558.689630] Starting dynamic subtest: pipe-D-eDP-1
[559.451137] Dynamic subtest pipe-D-eDP-1: SKIP (0.766s)
[559.455396] Subtest test-cursor-atomic: SKIP (4.512s)
[560.661619] [FACT kms_async_flips (test-cursor-atomic)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[560.662807] [FACT kms_async_flips (test-cursor-atomic)] new: kernel.kmod_is_loaded.i915: true
[560.667536] [102/133] (460s left) gem_exec_params (invalid-bsd-ring)
[560.742207] Starting subtest: invalid-bsd-ring
[560.744543] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[560.843658] [103/133] (460s left) gem_exec_reloc (basic-gtt-active)
[560.899034] Subtest basic-gtt-active: SKIP (0.000s)
[560.966732] [104/133] (460s left) kms_fbcon_fbt (fbc)
[561.010321] Starting subtest: fbc
[567.404677] Subtest fbc: SUCCESS (6.393s)
[568.493022] [105/133] (452s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[568.626534] Starting subtest: protected-encrypted-src-copy-not-readible
[568.740934] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.115s)
[568.847078] [106/133] (452s left) gem_exec_balancer (invalid-bonds)
[568.914180] Starting subtest: invalid-bonds
[568.918833] Subtest invalid-bonds: SKIP (0.000s)
[569.207849] [107/133] (452s left) kms_color (invalid-degamma-lut-sizes)
[569.298501] Starting subtest: invalid-degamma-lut-sizes
[569.300828] Starting dynamic subtest: pipe-A
[569.592817] Dynamic subtest pipe-A: SUCCESS (0.293s)
[569.602433] Starting dynamic subtest: pipe-B
[569.604769] Dynamic subtest pipe-B: SUCCESS (0.000s)
[569.613442] Starting dynamic subtest: pipe-C
[569.615779] Dynamic subtest pipe-C: SUCCESS (0.000s)
[569.625565] Starting dynamic subtest: pipe-D
[569.627451] Dynamic subtest pipe-D: SUCCESS (0.000s)
[569.629322] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s)
[570.445885] [108/133] (450s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[570.555521] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[570.557857] Starting dynamic subtest: pipe-A-eDP-1
[570.582199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[570.591580] Starting dynamic subtest: pipe-B-eDP-1
[570.612039] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[570.621054] Starting dynamic subtest: pipe-C-eDP-1
[570.643220] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[570.654638] Starting dynamic subtest: pipe-D-eDP-1
[570.675041] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[570.677375] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.098s)
[572.891975] [109/133] (448s left) kms_psr (pr-cursor-plane-move)
[572.995643] Starting subtest: pr-cursor-plane-move
[572.999596] Subtest pr-cursor-plane-move: SKIP (0.000s)
[573.066162] [110/133] (448s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[573.119546] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[573.190348] [111/133] (448s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[573.283535] Starting subtest: plane-primary-toggle-with-vblank-wait
[573.285820] Starting dynamic subtest: pipe-A-eDP-1
[573.456283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[573.765089] Starting dynamic subtest: pipe-B-eDP-1
[574.697933] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.942s)
[574.996862] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.713s)
[575.860658] [112/133] (445s left) i915_hangman (error-state-basic)
[575.917715] Starting subtest: error-state-basic
[576.000614] Subtest error-state-basic: SUCCESS (0.082s)
[576.073601] [113/133] (445s left) kms_psr (fbc-psr-primary-mmap-cpu)
[576.161467] Starting subtest: fbc-psr-primary-mmap-cpu
[576.163763] Starting dynamic subtest: eDP-1
[576.168190] Dynamic subtest eDP-1: SKIP (0.000s)
[576.172584] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[576.236630] [114/133] (445s left) gen9_exec_parse (basic-rejected)
[576.302784] Subtest basic-rejected: SKIP (0.000s)
[576.384035] [115/133] (445s left) core_auth (basic-auth)
[576.437392] Starting subtest: basic-auth
[576.439668] Subtest basic-auth: SUCCESS (0.001s)
[576.535779] [116/133] (445s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[576.643300] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[576.647454] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[576.712948] [117/133] (445s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[576.762782] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[576.863302] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[576.940711] [118/133] (444s left) gem_flink_basic (double-flink)
[576.996789] Starting subtest: double-flink
[576.999055] Subtest double-flink: SUCCESS (0.000s)
[577.093315] [119/133] (444s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[577.190640] Starting subtest: yf-tiled-32bpp-rotate-90
[577.194607] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[577.295861] [120/133] (444s left) syncobj_wait (multi-wait-for-submit-submitted)
[577.354651] Starting subtest: multi-wait-for-submit-submitted
[577.464181] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[577.541285] [121/133] (444s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[577.652569] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[577.656484] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[577.758126] [122/133] (444s left) gem_mmap (short-mmap)
[577.825925] Subtest short-mmap: SKIP (0.000s)
[577.881842] [123/133] (444s left) gem_exec_flush (basic-uc-rw-default)
[577.940312] Starting subtest: basic-uc-rw-default
[583.411191] Subtest basic-uc-rw-default: SUCCESS (5.473s)
[583.593669] [124/133] (438s left) gem_exec_schedule (u-fairslice)
[583.666389] Starting subtest: u-fairslice
[583.668787] Starting dynamic subtest: rcs0
[585.698070] Dynamic subtest rcs0: SUCCESS (2.035s)
[585.707168] Starting dynamic subtest: bcs0
[587.729604] Dynamic subtest bcs0: SUCCESS (2.027s)
[587.740227] Starting dynamic subtest: vcs0
[589.753940] Dynamic subtest vcs0: SUCCESS (2.025s)
[589.764524] Starting dynamic subtest: vcs1
[591.777590] Dynamic subtest vcs1: SUCCESS (2.018s)
[591.786199] Starting dynamic subtest: vecs0
[593.795870] Dynamic subtest vecs0: SUCCESS (2.020s)
[593.805682] Starting dynamic subtest: ccs0
[595.815581] Dynamic subtest ccs0: SUCCESS (2.020s)
[595.817906] Subtest u-fairslice: SUCCESS (12.153s)
[596.118334] [125/133] (425s left) gem_ctx_isolation (preservation-reset)
[596.295660] Starting subtest: preservation-reset
[596.297823] Starting dynamic subtest: rcs0
[596.592177] Dynamic subtest rcs0: SUCCESS (0.299s)
[596.605317] Starting dynamic subtest: bcs0
[596.933311] Dynamic subtest bcs0: SUCCESS (0.340s)
[596.946075] Starting dynamic subtest: vcs0
[597.254168] Dynamic subtest vcs0: SUCCESS (0.320s)
[597.266502] Starting dynamic subtest: vcs1
[599.274633] Dynamic subtest vcs1: SUCCESS (2.019s)
[599.285758] Starting dynamic subtest: vecs0
[601.264403] Dynamic subtest vecs0: SUCCESS (1.989s)
[601.273806] Starting dynamic subtest: ccs0
[603.255189] Dynamic subtest ccs0: SUCCESS (1.989s)
[603.258047] Subtest preservation-reset: SUCCESS (6.966s)
[603.401714] [126/133] (418s left) gen9_exec_parse (unaligned-jump)
[603.462113] Subtest unaligned-jump: SKIP (0.000s)
[603.521823] [127/133] (418s left) kms_vblank (ts-continuation-dpms-rpm)
[603.615324] Starting subtest: ts-continuation-dpms-rpm
[603.617577] Starting dynamic subtest: pipe-A-eDP-1
[606.156347] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.542s)
[606.172485] Starting dynamic subtest: pipe-D-eDP-1
[608.402154] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[608.404378] Subtest ts-continuation-dpms-rpm: SUCCESS (4.787s)
[609.197161] [128/133] (413s left) kms_psr (psr2-cursor-plane-move)
[609.288412] Starting subtest: psr2-cursor-plane-move
[609.290731] Starting dynamic subtest: eDP-1
[610.970365] Dynamic subtest eDP-1: SUCCESS (1.683s)
[610.972679] Subtest psr2-cursor-plane-move: SUCCESS (1.684s)
[611.765049] [129/133] (410s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[611.860570] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[611.886773] Starting dynamic subtest: pipe-A-plane-0
[612.187017] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[612.198542] Starting dynamic subtest: pipe-A-plane-3
[612.430853] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[612.440037] Starting dynamic subtest: pipe-A-plane-5
[612.448050] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[613.546510] Starting dynamic subtest: pipe-B-plane-0
[613.837211] Dynamic subtest pipe-B-plane-0: SUCCESS (0.299s)
[613.846468] Starting dynamic subtest: pipe-B-plane-3
[614.071152] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[614.082577] Starting dynamic subtest: pipe-B-plane-5
[614.086935] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[614.384716] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.526s)
[615.219990] [130/133] (407s left) gem_mmap_gtt (basic-wc)
[615.283755] Subtest basic-wc: SKIP (0.000s)
[615.356085] [131/133] (406s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[615.460093] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[619.839233] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.383s)
[621.028258] [132/133] (401s left) gem_eio (in-flight-1us)
[621.253144] Starting subtest: in-flight-1us
[629.814843] Subtest in-flight-1us: SUCCESS (8.561s)
[629.947226] [133/133] (392s left) kms_lease (lease-unleased-connector)
[630.042022] Starting subtest: lease-unleased-connector
[630.044248] Starting dynamic subtest: pipe-A-eDP-1
[630.049198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[630.059368] Starting dynamic subtest: pipe-B-eDP-1
[630.061519] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[630.071217] Starting dynamic subtest: pipe-C-eDP-1
[630.073306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[630.082843] Starting dynamic subtest: pipe-D-eDP-1
[630.084994] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[630.087147] Subtest lease-unleased-connector: SUCCESS (0.040s)
[630.187022] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_create
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_chamelium_frames
results: parsing output: 7/ for test: kms_prime
results: parsing output: 8/ for test: kms_pm_backlight
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_ctx_engines
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_scaling_modes
results: parsing output: 14/ for test: gem_exec_basic
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: kms_chamelium_color
results: parsing output: 23/ for test: i915_pm_rps
results: parsing output: 24/ for test: prime_mmap
results: parsing output: 25/ for test: kms_multipipe_modeset
results: parsing output: 26/ for test: gem_exec_parallel
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_spin_batch
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: gem_set_tiling_vs_blt
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_selftest
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: prime_busy
results: parsing output: 59/ for test: gem_exec_create
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_ctx_create
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_ctx_shared
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: syncobj_basic
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_draw_crc
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_setmode
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: i915_selftest
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_fbcon_fbt
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_color
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_pipe_b_c_ivb
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: core_auth
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_flink_basic
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_mmap
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_lease
Done.