[57.496400] Initializing watchdogs
[57.496447]   /dev/watchdog0
[57.511329] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.515634] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.517858] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.521668] [001/132] (960s left) perf (polling)
[57.683319] Starting subtest: polling
[57.685414] Starting dynamic subtest: 0-rcs0
[67.701285] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[67.708531] Starting dynamic subtest: 1-vecs0
[77.722373] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[77.724725] Subtest polling: SUCCESS (20.040s)
[77.769614] [002/132] (940s left) kms_psr2_su (page_flip-p010)
[77.825455] Subtest page_flip-P010: SKIP (0.000s)
[77.888704] [003/132] (940s left) syncobj_timeline (wait-all-snapshot)
[77.953391] Starting subtest: wait-all-snapshot
[78.035350] Subtest wait-all-snapshot: SUCCESS (0.084s)
[78.124874] [004/132] (940s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[78.179832] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[78.231557] [005/132] (939s left) kms_feature_discovery (display-3x)
[78.330773] Starting subtest: display-3x
[78.335211] Subtest display-3x: SKIP (0.000s)
[78.402192] [006/132] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[78.496599] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[78.501072] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[78.592627] [007/132] (939s left) sysfs_timeslice_duration (duration)
[78.658561] Starting subtest: duration
[78.660775] Starting dynamic subtest: vecs0
[91.892913] Dynamic subtest vecs0: SUCCESS (13.231s)
[91.903792] Starting dynamic subtest: ccs0
[105.046920] Dynamic subtest ccs0: SUCCESS (13.154s)
[105.056513] Starting dynamic subtest: vcs0
[118.837230] Dynamic subtest vcs0: SUCCESS (13.787s)
[118.849181] Starting dynamic subtest: bcs0
[131.976261] Dynamic subtest bcs0: SUCCESS (13.138s)
[131.992367] Starting dynamic subtest: rcs0
[145.114661] Dynamic subtest rcs0: SUCCESS (13.138s)
[145.126657] Starting dynamic subtest: vcs1
[159.859555] Dynamic subtest vcs1: SUCCESS (14.742s)
[159.863373] Subtest duration: SUCCESS (81.197s)
[159.935315] [008/132] (858s left) kms_cursor_edge_walk (256x256-top-edge)
[160.029373] Starting subtest: 256x256-top-edge
[160.033559] Starting dynamic subtest: pipe-A-eDP-1
[164.216901] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.183s)
[164.225887] Starting dynamic subtest: pipe-D-eDP-1
[166.915686] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.700s)
[166.918086] Subtest 256x256-top-edge: SUCCESS (6.886s)
[167.715769] [009/132] (850s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[167.849738] Starting subtest: 2x-cursor-vs-flip-legacy
[167.854186] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[167.988732] [010/132] (850s left) api_intel_allocator (two-level-inception)
[168.036822] Starting subtest: two-level-inception
[173.436064] Subtest two-level-inception: SUCCESS (5.400s)
[173.558807] [011/132] (844s left) gem_tiled_pread_basic (basic)
[173.617278] Subtest basic: SKIP (0.000s)
[173.685780] [012/132] (844s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[173.786873] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[173.813796] Starting dynamic subtest: pipe-A-plane-0
[174.247224] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[174.255948] Starting dynamic subtest: pipe-A-plane-3
[174.502112] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[175.600267] Starting dynamic subtest: pipe-B-plane-0
[176.037669] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[176.047881] Starting dynamic subtest: pipe-B-plane-3
[176.304331] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[176.618650] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.832s)
[177.463951] [013/132] (841s left) kms_flip (nonblocking-read)
[177.564368] Starting subtest: nonblocking-read
[177.566318] Subtest nonblocking-read: SUCCESS (0.000s)
[177.660051] [014/132] (840s left) kms_content_protection (uevent-hdcp14)
[177.809537] Starting subtest: uevent-hdcp14
[177.813830] Subtest uevent-hdcp14: SKIP (0.000s)
[177.920852] [015/132] (840s left) gem_render_copy (x-tiled)
[177.972202] Starting subtest: x-tiled
[177.974540] Starting dynamic subtest: smem
[178.015603] Dynamic subtest smem: SUCCESS (0.043s)
[178.017902] Subtest x-tiled: SUCCESS (0.044s)
[178.238996] [016/132] (840s left) gem_exec_balancer (individual)
[178.304438] Starting subtest: individual
[179.939853] Subtest individual: SUCCESS (1.633s)
[180.279607] [017/132] (838s left) kms_plane (plane-position-covered)
[180.388692] Starting subtest: plane-position-covered
[180.923496] Starting dynamic subtest: pipe-A-plane-1
[182.301996] Dynamic subtest pipe-A-plane-1: SUCCESS (1.380s)
[182.311844] Starting dynamic subtest: pipe-A-plane-2
[183.587286] Dynamic subtest pipe-A-plane-2: SUCCESS (1.284s)
[183.597193] Starting dynamic subtest: pipe-A-plane-3
[184.842986] Dynamic subtest pipe-A-plane-3: SUCCESS (1.256s)
[184.852178] Starting dynamic subtest: pipe-A-plane-4
[186.186525] Dynamic subtest pipe-A-plane-4: SUCCESS (1.342s)
[186.195838] Starting dynamic subtest: pipe-A-plane-5
[186.210637] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[187.446734] Starting dynamic subtest: pipe-B-plane-1
[188.785678] Dynamic subtest pipe-B-plane-1: SUCCESS (1.348s)
[188.796772] Starting dynamic subtest: pipe-B-plane-2
[190.084574] Dynamic subtest pipe-B-plane-2: SUCCESS (1.296s)
[190.093614] Starting dynamic subtest: pipe-B-plane-3
[191.406962] Dynamic subtest pipe-B-plane-3: SUCCESS (1.323s)
[191.416853] Starting dynamic subtest: pipe-B-plane-4
[192.745681] Dynamic subtest pipe-B-plane-4: SUCCESS (1.337s)
[192.755061] Starting dynamic subtest: pipe-B-plane-5
[192.769636] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[192.772092] Subtest plane-position-covered: SUCCESS (12.381s)
[193.626274] [018/132] (825s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[193.716118] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[193.718514] Starting dynamic subtest: pipe-A
[193.736246] Dynamic subtest pipe-A: SKIP (0.018s)
[193.744897] Starting dynamic subtest: pipe-B
[193.769826] Dynamic subtest pipe-B: SKIP (0.032s)
[193.777777] Starting dynamic subtest: pipe-C
[193.805429] Dynamic subtest pipe-C: SKIP (0.037s)
[193.813054] Starting dynamic subtest: pipe-D
[193.837939] Dynamic subtest pipe-D: SKIP (0.032s)
[193.841667] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.120s)
[193.964563] [019/132] (824s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[194.063065] Starting subtest: psr-shrfb-scaledprimary
[199.803035] Subtest psr-shrfb-scaledprimary: SUCCESS (5.742s)
[199.928570] [020/132] (818s left) kms_pm_backlight (fade-with-suspend)
[200.015110] Starting subtest: fade-with-suspend
[216.320858] Starting dynamic subtest: eDP-1
[218.801002] Dynamic subtest eDP-1: SUCCESS (2.483s)
[218.803436] Subtest fade-with-suspend: SUCCESS (4.977s)
[223.630215] [021/132] (799s left) kms_draw_crc (fill-fb)
[223.755989] Starting subtest: fill-fb
[224.218694] Subtest fill-fb: SUCCESS (0.464s)
[224.333756] [022/132] (798s left) perf (global-sseu-config)
[224.426812] Starting subtest: global-sseu-config
[224.431473] Subtest global-sseu-config: SKIP (0.000s)
[224.468402] [023/132] (798s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[224.524166] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[224.526159] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[224.611490] [024/132] (798s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[224.708233] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[224.710155] Starting dynamic subtest: pipe-A-eDP-1
[224.727242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[224.739712] Starting dynamic subtest: pipe-B-eDP-1
[224.755882] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[224.766719] Starting dynamic subtest: pipe-C-eDP-1
[224.782497] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[224.791761] Starting dynamic subtest: pipe-D-eDP-1
[224.807985] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[224.809558] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[226.972628] [025/132] (796s left) perf_pmu (invalid-open)
[227.011946] Starting subtest: invalid-open
[227.014337] Subtest invalid-open: SUCCESS (0.000s)
[227.110660] [026/132] (795s left) kms_cursor_crc (cursor-random-32x10)
[227.277916] Starting subtest: cursor-random-32x10
[227.324392] Subtest cursor-random-32x10: SKIP (0.042s)
[227.587226] [027/132] (795s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[227.650237] Starting subtest: y-tiled-ccs-to-x-tiled
[227.654673] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[227.832755] [028/132] (795s left) kms_rmfb (close-fd)
[227.936772] Starting subtest: close-fd
[227.939049] Starting dynamic subtest: pipe-A-eDP-1
[228.044990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[228.055526] Starting dynamic subtest: pipe-B-eDP-1
[229.239713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[229.250396] Starting dynamic subtest: pipe-C-eDP-1
[230.373006] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[230.382317] Starting dynamic subtest: pipe-D-eDP-1
[231.501092] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[231.503610] Subtest close-fd: SUCCESS (3.564s)
[232.712662] [029/132] (790s left) gem_close_race (basic-threads)
[232.787960] Starting subtest: basic-threads
[234.137753] Subtest basic-threads: SUCCESS (1.352s)
[234.317008] [030/132] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[234.407253] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[234.411309] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[234.504102] [031/132] (788s left) gem_exec_balancer (waits)
[234.560252] Starting subtest: waits
[241.070830] Subtest waits: SUCCESS (6.509s)
[241.385250] [032/132] (781s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[241.505521] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[241.510162] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[241.595001] [033/132] (781s left) kms_async_flips (invalid-async-flip)
[241.686097] Starting subtest: invalid-async-flip
[242.059074] Starting dynamic subtest: pipe-A-eDP-1
[242.838011] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s)
[243.209903] Starting dynamic subtest: pipe-B-eDP-1
[243.986803] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[244.345734] Starting dynamic subtest: pipe-C-eDP-1
[245.111992] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.772s)
[245.475378] Starting dynamic subtest: pipe-D-eDP-1
[246.260100] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.793s)
[246.262533] Subtest invalid-async-flip: SUCCESS (4.577s)
[247.406311] [034/132] (775s left) gem_ctx_isolation (clean)
[247.486698] Starting subtest: clean
[247.489011] Starting dynamic subtest: rcs0
[247.533067] Dynamic subtest rcs0: SUCCESS (0.049s)
[247.543909] Starting dynamic subtest: bcs0
[247.607514] Dynamic subtest bcs0: SUCCESS (0.074s)
[247.616521] Starting dynamic subtest: vcs0
[247.661951] Dynamic subtest vcs0: SUCCESS (0.054s)
[247.670851] Starting dynamic subtest: vcs1
[248.706180] Dynamic subtest vcs1: SUCCESS (1.043s)
[248.716570] Starting dynamic subtest: vecs0
[250.721164] Dynamic subtest vecs0: SUCCESS (2.014s)
[250.732108] Starting dynamic subtest: ccs0
[252.744000] Dynamic subtest ccs0: SUCCESS (2.022s)
[252.746479] Subtest clean: SUCCESS (5.260s)
[252.981756] [035/132] (770s left) gem_exec_schedule (preempt-engines)
[253.042769] Starting subtest: preempt-engines
[253.045050] Starting dynamic subtest: rcs0
[255.394088] Dynamic subtest rcs0: SUCCESS (2.357s)
[255.405791] Starting dynamic subtest: bcs0
[257.700867] Dynamic subtest bcs0: SUCCESS (2.305s)
[257.713099] Starting dynamic subtest: vcs0
[259.983967] Dynamic subtest vcs0: SUCCESS (2.282s)
[259.996375] Starting dynamic subtest: vcs1
[262.280714] Dynamic subtest vcs1: SUCCESS (2.294s)
[262.292696] Starting dynamic subtest: vecs0
[264.570722] Dynamic subtest vecs0: SUCCESS (2.289s)
[264.582858] Starting dynamic subtest: ccs0
[266.892614] Dynamic subtest ccs0: SUCCESS (2.321s)
[266.894846] Subtest preempt-engines: SUCCESS (13.856s)
[267.194276] [036/132] (756s left) kms_vblank (query-forked-hang)
[267.287285] Starting subtest: query-forked-hang
[267.289593] Starting dynamic subtest: pipe-A-eDP-1
[293.456143] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.165s)
[293.469786] Starting dynamic subtest: pipe-D-eDP-1
[318.536468] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.077s)
[318.538671] Subtest query-forked-hang: SUCCESS (51.247s)
[319.382142] [037/132] (704s left) kms_flip (basic-plain-flip)
[319.475208] Starting subtest: basic-plain-flip
[319.477092] Starting dynamic subtest: A-eDP1
[321.178410] Dynamic subtest A-eDP1: SUCCESS (1.703s)
[321.189562] Starting dynamic subtest: B-eDP1
[322.807181] Dynamic subtest B-eDP1: SUCCESS (1.626s)
[322.818223] Starting dynamic subtest: C-eDP1
[324.438279] Dynamic subtest C-eDP1: SUCCESS (1.629s)
[324.448741] Starting dynamic subtest: D-eDP1
[326.073385] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[326.078778] Subtest basic-plain-flip: SUCCESS (6.604s)
[327.241017] [038/132] (696s left) kms_addfb_basic (size-max)
[327.345799] Starting subtest: size-max
[327.347714] Subtest size-max: SUCCESS (0.000s)
[327.439769] [039/132] (696s left) gem_userptr_blits (create-destroy-sync)
[327.508495] Starting subtest: create-destroy-sync
[332.531318] Subtest create-destroy-sync: SUCCESS (5.021s)
[332.644777] [040/132] (690s left) kms_psr (psr-sprite-plane-onoff)
[332.737955] Starting subtest: psr-sprite-plane-onoff
[332.740290] Starting dynamic subtest: eDP-1
[334.754999] Dynamic subtest eDP-1: SUCCESS (2.016s)
[334.757367] Subtest psr-sprite-plane-onoff: SUCCESS (2.017s)
[335.572014] [041/132] (688s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[335.694615] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[367.305131] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.607s)
[368.104794] [042/132] (655s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[368.213951] Starting subtest: 4-tiled-32bpp-rotate-90
[368.233411] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[368.338498] [043/132] (655s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[368.432362] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[368.436354] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[368.500703] [044/132] (655s left) kms_addfb_basic (master-rmfb)
[368.558064] Starting subtest: master-rmfb
[368.560314] Subtest master-rmfb: SUCCESS (0.002s)
[368.722857] [045/132] (655s left) kms_prime (d3hot)
[368.804798] Subtest D3hot: SKIP (0.000s)
[368.946333] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[368.949986] [046/132] (654s left) kms_fbcon_fbt (psr)
[369.007814] Starting subtest: psr
[376.420630] Subtest psr: SUCCESS (7.411s)
[376.498459] [047/132] (647s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[376.622999] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[376.627098] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[376.744463] [048/132] (647s left) kms_busy (extended-pageflip-hang-oldfb)
[376.852048] Starting subtest: extended-pageflip-hang-oldfb
[376.854307] Starting dynamic subtest: pipe-A
[377.319880] Dynamic subtest pipe-A: SUCCESS (0.464s)
[377.332864] Starting dynamic subtest: pipe-D
[378.462252] Dynamic subtest pipe-D: SUCCESS (1.139s)
[378.464428] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.610s)
[379.303319] [049/132] (644s left) gem_render_linear_blits (basic)
[379.357865] Starting subtest: basic
[379.379505] Subtest basic: SUCCESS (0.022s)
[379.476780] [050/132] (644s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[379.572098] Starting subtest: bad-aux-stride-yf-tiled-ccs
[379.574376] Starting dynamic subtest: pipe-A-eDP-1
[379.597566] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.608448] Starting dynamic subtest: pipe-B-eDP-1
[379.630265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.639385] Starting dynamic subtest: pipe-C-eDP-1
[379.661244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.671574] Starting dynamic subtest: pipe-D-eDP-1
[379.693283] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.697321] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[381.860403] [051/132] (642s left) gem_userptr_blits (unsync-unmap)
[381.928753] Subtest unsync-unmap: SKIP (0.000s)
[382.060229] [052/132] (642s left) core_getclient (basic)
[382.132521] Starting subtest: basic
[382.134784] Subtest basic: SUCCESS (0.000s)
[382.239204] [053/132] (641s left) gem_mmap_wc (invalid-flags)
[382.297514] Subtest invalid-flags: SKIP (0.000s)
[382.363980] [054/132] (641s left) gem_create (create-ext-placement-sanity-check)
[382.525957] Starting subtest: create-ext-placement-sanity-check
[382.532303] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[382.639572] [055/132] (641s left) kms_pipe_stress (stress-xrgb8888-untiled)
[382.745160] Starting subtest: stress-xrgb8888-untiled
[388.666682] Subtest stress-xrgb8888-untiled: SUCCESS (5.924s)
[388.721291] [056/132] (635s left) i915_drm_fdinfo (context-close-stress)
[388.761640] Starting subtest: context-close-stress
[399.509098] Subtest context-close-stress: SUCCESS (10.746s)
[399.602240] [057/132] (624s left) perf (invalid-oa-exponent)
[399.693877] Starting subtest: invalid-oa-exponent
[399.711087] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[399.749316] [058/132] (624s left) gem_exec_reloc (basic-write-wc)
[399.918366] Subtest basic-write-wc: SKIP (0.000s)
[399.983931] [059/132] (624s left) kms_psr (pr-cursor-plane-move)
[400.093252] Starting subtest: pr-cursor-plane-move
[400.097793] Subtest pr-cursor-plane-move: SKIP (0.000s)
[400.178278] [060/132] (624s left) gem_exec_schedule (promotion)
[400.263012] Starting subtest: promotion
[400.264901] Starting dynamic subtest: rcs0
[400.369218] Dynamic subtest rcs0: SUCCESS (0.112s)
[400.380657] Starting dynamic subtest: vcs0
[400.467127] Dynamic subtest vcs0: SUCCESS (0.097s)
[400.479277] Starting dynamic subtest: vcs1
[400.552048] Dynamic subtest vcs1: SUCCESS (0.083s)
[400.564580] Starting dynamic subtest: vecs0
[400.639333] Dynamic subtest vecs0: SUCCESS (0.087s)
[400.653591] Starting dynamic subtest: ccs0
[400.726695] Dynamic subtest ccs0: SUCCESS (0.086s)
[400.729121] Subtest promotion: SUCCESS (0.470s)
[401.826943] [061/132] (622s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[401.914344] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[401.918681] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[402.018214] [062/132] (622s left) gen9_exec_parse (batch-without-end)
[402.085341] Subtest batch-without-end: SKIP (0.000s)
[402.160504] [063/132] (622s left) kms_psr (psr2-cursor-plane-onoff)
[402.254150] Starting subtest: psr2-cursor-plane-onoff
[402.256387] Starting dynamic subtest: eDP-1
[403.935677] Dynamic subtest eDP-1: SUCCESS (1.682s)
[403.937984] Subtest psr2-cursor-plane-onoff: SUCCESS (1.683s)
[404.812437] [064/132] (619s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[404.912028] Starting subtest: fbc-psr-cursor-mmap-cpu
[404.914409] Starting dynamic subtest: eDP-1
[404.918683] Dynamic subtest eDP-1: SKIP (0.000s)
[404.922982] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[404.985616] [065/132] (619s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[405.092210] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[409.111617] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.022s)
[410.232876] [066/132] (614s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[410.334513] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[410.336696] Starting dynamic subtest: pipe-A-eDP-1
[427.520264] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[427.535462] Starting dynamic subtest: pipe-B-eDP-1
[445.532918] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.873s)
[445.544488] Starting dynamic subtest: pipe-C-eDP-1
[463.492662] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[463.502430] Starting dynamic subtest: pipe-D-eDP-1
[481.476884] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.687s)
[481.479047] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.154s)
[487.636383] [067/132] (542s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[487.717216] Starting subtest: map-fixed-invalidate-overlap
[487.721871] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[487.838489] [068/132] (541s left) gem_mmap (bad-size)
[487.900505] Subtest bad-size: SKIP (0.000s)
[487.961712] [069/132] (541s left) i915_pm_rps (reset)
[488.024189] Starting subtest: reset
[496.503343] Subtest reset: SUCCESS (8.466s)
[496.618457] [070/132] (533s left) dmabuf_sync_file (import-basic)
[496.666030] Starting subtest: import-basic
[496.668329] Subtest import-basic: SUCCESS (0.002s)
[496.731508] [071/132] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[496.826276] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[496.830677] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.930534] [072/132] (533s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[497.007639] Starting subtest: yf-tiled-to-vebox-yf-tiled
[497.011724] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[497.189392] [073/132] (532s left) kms_joiner (invalid-modeset-ultra-joiner)
[497.287398] Starting subtest: invalid-modeset-ultra-joiner
[497.291403] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[497.355316] [074/132] (532s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[497.449242] Starting subtest: random-ccs-data-y-tiled-ccs
[497.451466] Starting dynamic subtest: pipe-A-eDP-1
[497.476731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[497.487210] Starting dynamic subtest: pipe-B-eDP-1
[497.509929] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[497.518543] Starting dynamic subtest: pipe-C-eDP-1
[497.541095] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[497.549590] Starting dynamic subtest: pipe-D-eDP-1
[497.572429] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[497.576752] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[499.692924] [075/132] (530s left) sriov_basic (bind-unbind-vf)
[499.757611] Starting subtest: bind-unbind-vf
[499.760045] Starting dynamic subtest: vf-1
[499.831109] Dynamic subtest vf-1: FAIL (0.015s)
[499.841362] Starting dynamic subtest: vf-2
[499.910405] Dynamic subtest vf-2: FAIL (0.004s)
[499.920848] Starting dynamic subtest: vf-3
[499.989558] Dynamic subtest vf-3: FAIL (0.003s)
[499.998789] Starting dynamic subtest: vf-4
[500.067155] Dynamic subtest vf-4: FAIL (0.004s)
[500.077042] Starting dynamic subtest: vf-5
[500.145385] Dynamic subtest vf-5: FAIL (0.003s)
[500.155075] Starting dynamic subtest: vf-6
[500.224125] Dynamic subtest vf-6: FAIL (0.004s)
[500.233363] Starting dynamic subtest: vf-7
[500.303113] Dynamic subtest vf-7: FAIL (0.003s)
[500.312623] Starting dynamic subtest: vf-random
[500.381703] Dynamic subtest vf-random: FAIL (0.004s)
[500.391385] Starting dynamic subtest: vf-last
[500.460594] Dynamic subtest vf-last: FAIL (0.486s)
[500.462858] Subtest bind-unbind-vf: FAIL (0.534s)
[500.501946] [076/132] (529s left) gem_lmem_swapping (heavy-multi)
[500.550999] Subtest heavy-multi: SKIP (0.000s)
[500.589495] [077/132] (529s left) syncobj_timeline (invalid-query-bad-pad)
[500.636778] Starting subtest: invalid-query-bad-pad
[500.638607] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[500.737065] [078/132] (529s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[500.862268] Starting subtest: basic-flip-after-cursor-atomic
[501.788285] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.922s)
[502.633236] [079/132] (527s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[502.732161] Starting subtest: psr-rgb101010-draw-mmap-cpu
[509.841878] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.110s)
[509.958746] [080/132] (520s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[510.062066] Starting subtest: yf-tiled-32bpp-rotate-90
[510.066101] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[510.162514] [081/132] (520s left) gem_mmap_offset (bad-extensions)
[510.216435] Starting subtest: bad-extensions
[510.218536] Subtest bad-extensions: SUCCESS (0.000s)
[510.309934] [082/132] (520s left) kms_plane_multiple (2x-tiling-none)
[510.401582] Starting subtest: 2x-tiling-none
[510.405489] Subtest 2x-tiling-none: SKIP (0.000s)
[510.486492] [083/132] (519s left) gem_exec_whisper (basic-contexts-priority)
[510.549376] Starting subtest: basic-contexts-priority
[535.092810] Subtest basic-contexts-priority: SUCCESS (24.546s)
[535.283067] [084/132] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[535.401315] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[535.405743] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[535.500525] [085/132] (495s left) kms_lease (multimaster-lease)
[535.586984] Starting subtest: multimaster-lease
[535.589536] Subtest multimaster-lease: SUCCESS (0.004s)
[535.699468] [086/132] (494s left) gem_tiled_partial_pwrite_pread (writes)
[535.761293] Subtest writes: SKIP (0.000s)
[535.844856] [087/132] (494s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[535.952164] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[542.690146] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.741s)
[542.806067] [088/132] (487s left) syncobj_wait (wait-for-submit-complex)
[542.867586] Starting subtest: wait-for-submit-complex
[542.929027] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[543.019038] [089/132] (487s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[543.112276] Starting subtest: x-tiled-16bpp-rotate-180
[544.514426] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.402s)
[544.638638] [090/132] (486s left) kms_atomic_interruptible (universal-setplane-primary)
[544.735076] Starting subtest: universal-setplane-primary
[544.736870] Starting dynamic subtest: pipe-A-eDP-1
[552.126009] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[552.128382] Subtest universal-setplane-primary: SUCCESS (7.388s)
[552.974975] [091/132] (477s left) gem_ctx_persistence (userptr)
[553.036266] Starting subtest: userptr
[553.206022] Subtest userptr: SUCCESS (0.170s)
[553.300243] [092/132] (477s left) kms_hdr (brightness-with-hdr)
[553.382516] Starting subtest: brightness-with-hdr
[553.389236] Subtest brightness-with-hdr: SKIP (0.000s)
[553.465590] [093/132] (477s left) gem_exec_parallel (userptr)
[553.535479] Starting subtest: userptr
[553.537823] Starting dynamic subtest: rcs0
[554.981351] Dynamic subtest rcs0: SUCCESS (1.445s)
[554.992652] Starting dynamic subtest: bcs0
[556.462026] Dynamic subtest bcs0: SUCCESS (1.478s)
[556.473209] Starting dynamic subtest: vcs0
[559.683593] Dynamic subtest vcs0: SUCCESS (3.218s)
[559.696130] Starting dynamic subtest: vcs1
[561.665450] Dynamic subtest vcs1: SUCCESS (1.979s)
[561.675631] Starting dynamic subtest: vecs0
[563.650319] Dynamic subtest vecs0: SUCCESS (1.982s)
[563.662918] Starting dynamic subtest: ccs0
[565.122047] Dynamic subtest ccs0: SUCCESS (1.470s)
[565.124546] Subtest userptr: SUCCESS (11.586s)
[565.314081] [094/132] (465s left) kms_flip (bo-too-big-interruptible)
[565.407688] Starting subtest: bo-too-big-interruptible
[565.409668] Starting dynamic subtest: A-eDP1
[566.734432] Dynamic subtest A-eDP1: SUCCESS (1.325s)
[566.746567] Starting dynamic subtest: B-eDP1
[568.017031] Dynamic subtest B-eDP1: SUCCESS (1.280s)
[568.029700] Starting dynamic subtest: C-eDP1
[569.320364] Dynamic subtest C-eDP1: SUCCESS (1.302s)
[569.332360] Starting dynamic subtest: D-eDP1
[570.649525] Dynamic subtest D-eDP1: SUCCESS (1.328s)
[570.654621] Subtest bo-too-big-interruptible: SUCCESS (5.246s)
[571.854049] [095/132] (459s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[571.948899] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[571.953351] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[572.026266] [096/132] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[572.132725] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[572.136931] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[572.232868] [097/132] (458s left) i915_suspend (debugfs-reader)
[572.280856] Starting subtest: debugfs-reader
[590.309013] Subtest debugfs-reader: SUCCESS (3.536s)
[595.503960] [098/132] (440s left) kms_cursor_legacy (forked-move)
[595.631888] Starting subtest: forked-move
[595.634046] Starting dynamic subtest: pipe-A
[601.099985] Dynamic subtest pipe-A: SUCCESS (5.458s)
[601.119136] Starting dynamic subtest: pipe-B
[606.572346] Dynamic subtest pipe-B: SUCCESS (5.465s)
[606.584752] Starting dynamic subtest: pipe-C
[612.047050] Dynamic subtest pipe-C: SUCCESS (5.469s)
[612.059294] Starting dynamic subtest: pipe-D
[617.516859] Dynamic subtest pipe-D: SUCCESS (5.465s)
[617.528881] Starting dynamic subtest: all-pipes
[623.023144] Dynamic subtest all-pipes: SUCCESS (5.501s)
[623.025676] Subtest forked-move: SUCCESS (27.370s)
[623.166059] [099/132] (413s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[623.277554] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[623.281583] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[623.374996] [100/132] (412s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[623.490082] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[624.502222] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.012s)
[624.626365] [101/132] (411s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[624.716829] Starting subtest: plane-primary-toggle-with-vblank-wait
[624.718832] Starting dynamic subtest: pipe-A-eDP-1
[624.890299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[625.210936] Starting dynamic subtest: pipe-B-eDP-1
[626.119434] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.918s)
[626.416747] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.700s)
[627.294300] [102/132] (409s left) gem_exec_fence (submit)
[627.466502] Starting subtest: submit
[627.471449] Subtest submit: SKIP (0.000s)
[629.320000] [103/132] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[629.418866] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[629.423348] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[629.522687] [104/132] (406s left) gem_render_copy (yf-tiled-ccs-to-linear)
[629.584738] Starting subtest: yf-tiled-ccs-to-linear
[629.589236] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[629.775061] [105/132] (406s left) kms_cursor_crc (cursor-onscreen-128x42)
[629.998155] Starting subtest: cursor-onscreen-128x42
[630.058314] Subtest cursor-onscreen-128x42: SKIP (0.057s)
[630.275298] [106/132] (406s left) kms_frontbuffer_tracking (psr-1p-rte)
[630.373568] Starting subtest: psr-1p-rte
[635.780587] Subtest psr-1p-rte: SUCCESS (5.410s)
[635.906061] [107/132] (400s left) gem_spin_batch (resubmit)
[635.967069] Starting subtest: resubmit
[635.969451] Starting dynamic subtest: rcs0
[635.974314] Dynamic subtest rcs0: SUCCESS (0.007s)
[635.990052] Starting dynamic subtest: bcs0
[635.992421] Dynamic subtest bcs0: SUCCESS (0.003s)
[636.002302] Starting dynamic subtest: vcs0
[636.004512] Dynamic subtest vcs0: SUCCESS (0.002s)
[636.013887] Starting dynamic subtest: vcs1
[636.016124] Dynamic subtest vcs1: SUCCESS (0.002s)
[636.025401] Starting dynamic subtest: vecs0
[636.027942] Dynamic subtest vecs0: SUCCESS (0.003s)
[636.040307] Starting dynamic subtest: ccs0
[636.042486] Dynamic subtest ccs0: SUCCESS (0.003s)
[636.044614] Subtest resubmit: SUCCESS (0.023s)
[636.218461] [108/132] (400s left) gem_exec_await (wide-contexts)
[636.408480] Starting subtest: wide-contexts
[660.345246] Subtest wide-contexts: SUCCESS (23.933s)
[660.551876] [109/132] (376s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[660.696759] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[661.500630] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.805s)
[661.688018] [110/132] (375s left) gem_mmap_gtt (basic-wc)
[661.739952] Subtest basic-wc: SKIP (0.000s)
[661.805522] [111/132] (374s left) kms_color_pipeline (plane-ctm3x4)
[661.899790] Starting subtest: plane-ctm3x4
[662.037248] Starting dynamic subtest: pipe-A-plane-0
[662.358481] Dynamic subtest pipe-A-plane-0: FAIL (0.159s)
[662.369228] Starting dynamic subtest: pipe-A-plane-1
[662.545867] Dynamic subtest pipe-A-plane-1: FAIL (0.149s)
[662.558095] Starting dynamic subtest: pipe-A-plane-2
[662.757028] Dynamic subtest pipe-A-plane-2: FAIL (0.153s)
[663.712588] Starting dynamic subtest: pipe-B-plane-0
[664.110096] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[664.120945] Starting dynamic subtest: pipe-B-plane-1
[664.415849] Dynamic subtest pipe-B-plane-1: FAIL (0.143s)
[664.427451] Starting dynamic subtest: pipe-B-plane-2
[664.720559] Dynamic subtest pipe-B-plane-2: FAIL (0.154s)
[665.309713] Starting dynamic subtest: pipe-C-plane-0
[665.751701] Dynamic subtest pipe-C-plane-0: FAIL (0.107s)
[665.765160] Starting dynamic subtest: pipe-C-plane-1
[666.151102] Dynamic subtest pipe-C-plane-1: FAIL (0.132s)
[666.162178] Starting dynamic subtest: pipe-C-plane-2
[666.499902] Dynamic subtest pipe-C-plane-2: FAIL (0.607s)
[667.353817] Starting dynamic subtest: pipe-D-plane-0
[667.887557] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[667.899894] Starting dynamic subtest: pipe-D-plane-1
[668.354308] Dynamic subtest pipe-D-plane-1: FAIL (0.585s)
[668.366222] Starting dynamic subtest: pipe-D-plane-2
[668.779067] Dynamic subtest pipe-D-plane-2: FAIL (0.545s)
[668.891383] Subtest plane-ctm3x4: FAIL (6.990s)
[669.736550] [112/132] (367s left) kms_psr (fbc-psr2-cursor-blt)
[669.833083] Starting subtest: fbc-psr2-cursor-blt
[669.835319] Starting dynamic subtest: eDP-1
[669.839385] Dynamic subtest eDP-1: SKIP (0.000s)
[669.843398] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[669.906993] [113/132] (366s left) i915_drm_fdinfo (virtual-idle)
[669.945849] Starting subtest: virtual-idle
[673.002194] Subtest virtual-idle: SUCCESS (3.055s)
[673.081666] [114/132] (363s left) gem_exec_async (concurrent-writes)
[673.150603] Starting subtest: concurrent-writes
[673.152543] Starting dynamic subtest: rcs0
[673.171095] Dynamic subtest rcs0: SUCCESS (0.023s)
[673.184327] Starting dynamic subtest: bcs0
[673.186510] Dynamic subtest bcs0: SUCCESS (0.011s)
[673.196815] Starting dynamic subtest: vcs0
[673.198860] Dynamic subtest vcs0: SUCCESS (0.009s)
[673.209356] Starting dynamic subtest: vcs1
[673.211236] Dynamic subtest vcs1: SUCCESS (0.008s)
[673.221007] Starting dynamic subtest: vecs0
[673.223171] Dynamic subtest vecs0: SUCCESS (0.009s)
[673.232858] Starting dynamic subtest: ccs0
[673.234719] Dynamic subtest ccs0: SUCCESS (0.012s)
[673.236594] Subtest concurrent-writes: SUCCESS (0.078s)
[673.480917] [115/132] (363s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[673.569225] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[673.571553] Starting dynamic subtest: pipe-A-default-mode
[676.256472] Dynamic subtest pipe-A-default-mode: SUCCESS (2.687s)
[676.258928] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.688s)
[677.115583] [116/132] (359s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[677.175915] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[677.285603] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[677.365895] [117/132] (359s left) kms_vblank (invalid)
[677.454215] Starting subtest: invalid
[677.456024] Starting dynamic subtest: pipe-A-eDP-1
[677.852688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[677.854585] Subtest invalid: SUCCESS (0.398s)
[678.655219] [118/132] (358s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[679.041157] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[679.872733] [119/132] (357s left) prime_vgem (basic-read)
[679.940626] Starting subtest: basic-read
[679.954461] Subtest basic-read: SKIP (0.011s)
[680.057019] [120/132] (357s left) gem_ccs (ctrl-surf-copy-new-ctx)
[680.121879] Starting subtest: ctrl-surf-copy-new-ctx
[680.126105] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[680.229963] [121/132] (356s left) kms_chamelium_frames (dp-crc-fast)
[680.624368] Subtest dp-crc-fast: SKIP (0.000s)
[681.403189] [122/132] (355s left) gem_userptr_blits (map-fixed-invalidate-busy)
[681.480665] Starting subtest: map-fixed-invalidate-busy
[681.484992] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[681.602616] [123/132] (355s left) gem_eio (in-flight-contexts-10ms)
[681.834177] Starting subtest: in-flight-contexts-10ms
[695.221622] Subtest in-flight-contexts-10ms: SUCCESS (13.385s)
[695.351587] [124/132] (341s left) gem_mmap_gtt (hang)
[695.418173] Subtest hang: SKIP (0.000s)
[695.478831] [125/132] (341s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[695.577556] Starting subtest: y-tiled-8bpp-rotate-90
[695.581733] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[695.677680] [126/132] (341s left) kms_flip (dpms-off-confusion-interruptible)
[695.780588] Starting subtest: dpms-off-confusion-interruptible
[695.782873] Starting dynamic subtest: A-eDP1
[704.423655] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[704.435852] Starting dynamic subtest: B-eDP1
[713.052972] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[713.064546] Starting dynamic subtest: C-eDP1
[721.669030] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[721.679334] Starting dynamic subtest: D-eDP1
[730.303378] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[730.308903] Subtest dpms-off-confusion-interruptible: SUCCESS (34.530s)
[731.478312] [127/132] (305s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[731.573467] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[731.575701] Starting dynamic subtest: pipe-A-eDP-1
[731.633350] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[731.643209] Starting dynamic subtest: pipe-B-eDP-1
[731.700322] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[731.712326] Starting dynamic subtest: pipe-C-eDP-1
[731.768981] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[731.780523] Starting dynamic subtest: pipe-D-eDP-1
[731.837919] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[731.842291] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.011s)
[733.830439] [128/132] (303s left) gem_pxp (create-protected-buffer)
[733.956352] Starting subtest: create-protected-buffer
[733.958936] Subtest create-protected-buffer: SUCCESS (0.000s)
[734.087034] [129/132] (303s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[734.183171] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[741.215674] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.034s)
[741.341010] [130/132] (296s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[741.400332] Starting subtest: single-wait-for-submit-unsubmitted
[741.508625] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[741.588458] [131/132] (296s left) syncobj_wait (invalid-reset-zero-handles)
[741.652925] Starting subtest: invalid-reset-zero-handles
[741.655280] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[741.759479] [132/132] (295s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[741.804993] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[741.807327] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[741.937500] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_psr2_su
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_mmap_wc
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: sysfs_timeslice_duration
results: parsing output: 7/ for test: kms_cursor_edge_walk
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: gem_tiled_pread_basic
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_draw_crc
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_rmfb
results: parsing output: 28/ for test: gem_close_race
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_async_flips
results: parsing output: 33/ for test: gem_ctx_isolation
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_prime
results: parsing output: 45/ for test: kms_fbcon_fbt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_busy
results: parsing output: 48/ for test: gem_render_linear_blits
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: core_getclient
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_pipe_stress
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: gem_mmap
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: dmabuf_sync_file
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_joiner
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: sriov_basic
results: parsing output: 75/ for test: gem_lmem_swapping
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: kms_plane_multiple
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_atomic_interruptible
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: kms_hdr
results: parsing output: 92/ for test: gem_exec_parallel
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: i915_suspend
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_atomic_transition
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_spin_batch
results: parsing output: 107/ for test: gem_exec_await
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_color_pipeline
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_async
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: kms_chamelium_frames
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: syncobj_timeline
Done.