[58.311238] Initializing watchdogs
[58.311285]   /dev/watchdog0
[58.325634] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.330096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.332489] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.335921] [001/133] (960s left) gem_exec_schedule (u-semaphore-resolve)
[58.429214] Starting subtest: u-semaphore-resolve
[58.491305] Subtest u-semaphore-resolve: SUCCESS (0.064s)
[58.850685] [002/133] (960s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[58.961167] Starting subtest: y-tiled-addfb-size-offset-overflow
[58.965371] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[59.049176] [003/133] (959s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[59.149041] Starting subtest: invalid-modeset-force-ultra-joiner
[59.153469] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[59.216669] [004/133] (959s left) perf (missing-sample-flags)
[59.354032] Starting subtest: missing-sample-flags
[59.356351] Subtest missing-sample-flags: SUCCESS (0.000s)
[59.390150] [005/133] (959s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[59.492782] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[59.495062] Starting dynamic subtest: A-eDP1
[63.127963] Dynamic subtest A-eDP1: SUCCESS (3.632s)
[63.142902] Starting dynamic subtest: B-eDP1
[66.337453] Dynamic subtest B-eDP1: SUCCESS (3.209s)
[66.346436] Starting dynamic subtest: C-eDP1
[69.450057] Dynamic subtest C-eDP1: SUCCESS (3.113s)
[69.457513] Starting dynamic subtest: D-eDP1
[72.551585] Dynamic subtest D-eDP1: SUCCESS (3.098s)
[72.553940] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.059s)
[73.348293] [006/133] (945s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[73.452251] Starting subtest: fbc-psr2-sprite-mmap-gtt
[73.454691] Starting dynamic subtest: eDP-1
[73.459316] Dynamic subtest eDP-1: SKIP (0.000s)
[73.463970] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[73.531810] [007/133] (945s left) gem_exec_fence (basic-busy-all)
[73.600474] Starting subtest: basic-busy-all
[73.683081] Subtest basic-busy-all: SUCCESS (0.084s)
[76.000087] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[76.003387] [008/133] (943s left) i915_drm_fdinfo (all-busy-idle-check-all)
[76.049823] Starting subtest: all-busy-idle-check-all
[76.054246] Subtest all-busy-idle-check-all: SKIP (0.003s)
[76.125701] [009/133] (943s left) gem_mmap_gtt (basic-wc)
[76.205517] Subtest basic-wc: SKIP (0.000s)
[76.270507] [010/133] (942s left) kms_psr (psr-cursor-render)
[76.372789] Starting subtest: psr-cursor-render
[76.375278] Starting dynamic subtest: eDP-1
[78.144208] Dynamic subtest eDP-1: SUCCESS (1.772s)
[78.146588] Subtest psr-cursor-render: SUCCESS (1.772s)
[79.021059] [011/133] (940s left) gem_userptr_blits (coherency-unsync)
[79.096198] Subtest coherency-unsync: SKIP (0.000s)
[79.223383] [012/133] (940s left) kms_pm_rpm (dpms-lpsp)
[80.975028] Starting subtest: dpms-lpsp
[81.480656] Subtest dpms-lpsp: SUCCESS (0.506s)
[81.591587] [013/133] (937s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[81.696894] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[81.699241] Starting dynamic subtest: pipe-A-eDP-1
[81.722080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[81.730207] Starting dynamic subtest: pipe-B-eDP-1
[81.752026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[81.759227] Starting dynamic subtest: pipe-C-eDP-1
[81.781097] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[81.788494] Starting dynamic subtest: pipe-D-eDP-1
[81.810609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[81.814734] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s)
[84.005107] [014/133] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[84.118631] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[84.122774] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[84.214211] [015/133] (935s left) kms_flip (2x-plain-flip-ts-check)
[84.310263] Starting subtest: 2x-plain-flip-ts-check
[84.320551] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[84.411330] [016/133] (935s left) syncobj_timeline (wait-any-complex)
[84.467788] Starting subtest: wait-any-complex
[84.529049] Subtest wait-any-complex: SUCCESS (0.062s)
[84.608828] [017/133] (934s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[84.988961] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[85.814530] [018/133] (933s left) gem_mmap_offset (partial-unmap)
[85.875669] Starting subtest: partial-unmap
[85.877944] Starting dynamic subtest: smem0
[86.384637] Dynamic subtest smem0: SUCCESS (0.508s)
[86.387743] Subtest partial-unmap: SUCCESS (0.509s)
[86.498087] [019/133] (933s left) gem_exec_fence (basic-await)
[86.670672] Starting subtest: basic-await
[86.673221] Starting dynamic subtest: rcs0
[86.747493] Dynamic subtest rcs0: SUCCESS (0.076s)
[86.759589] Starting dynamic subtest: bcs0
[86.819956] Dynamic subtest bcs0: SUCCESS (0.073s)
[86.830266] Starting dynamic subtest: vcs0
[86.893795] Dynamic subtest vcs0: SUCCESS (0.072s)
[86.904636] Starting dynamic subtest: vcs1
[86.967591] Dynamic subtest vcs1: SUCCESS (0.074s)
[86.978749] Starting dynamic subtest: vecs0
[87.042986] Dynamic subtest vecs0: SUCCESS (0.074s)
[87.053546] Starting dynamic subtest: ccs0
[87.116066] Dynamic subtest ccs0: SUCCESS (0.072s)
[87.118836] Subtest basic-await: SUCCESS (0.446s)
[89.011058] [020/133] (930s left) perf_pmu (semaphore-wait-idle)
[89.060923] Starting subtest: semaphore-wait-idle
[89.063728] Starting dynamic subtest: rcs0
[89.576272] Dynamic subtest rcs0: SUCCESS (0.517s)
[89.587709] Starting dynamic subtest: bcs0
[90.091919] Dynamic subtest bcs0: SUCCESS (0.513s)
[90.103245] Starting dynamic subtest: vcs0
[90.607868] Dynamic subtest vcs0: SUCCESS (0.513s)
[90.619065] Starting dynamic subtest: vcs1
[91.121222] Dynamic subtest vcs1: SUCCESS (0.512s)
[91.132055] Starting dynamic subtest: vecs0
[91.639662] Dynamic subtest vecs0: SUCCESS (0.516s)
[91.650324] Starting dynamic subtest: ccs0
[92.153204] Dynamic subtest ccs0: SUCCESS (0.513s)
[92.156059] Subtest semaphore-wait-idle: SUCCESS (3.095s)
[92.270879] [021/133] (927s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[92.372805] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[92.377200] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[92.481522] [022/133] (927s left) prime_mmap_coherency (ioctl-errors)
[92.544623] Starting subtest: ioctl-errors
[105.977762] Subtest ioctl-errors: SUCCESS (13.435s)
[106.137930] [023/133] (913s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[106.270070] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[106.273815] Starting dynamic subtest: A-eDP1
[109.850229] Dynamic subtest A-eDP1: SUCCESS (3.575s)
[109.859779] Starting dynamic subtest: B-eDP1
[113.066256] Dynamic subtest B-eDP1: SUCCESS (3.215s)
[113.075992] Starting dynamic subtest: C-eDP1
[116.249217] Dynamic subtest C-eDP1: SUCCESS (3.181s)
[116.260694] Starting dynamic subtest: D-eDP1
[119.364198] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[119.366579] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.094s)
[120.166394] [024/133] (899s left) gem_compute (compute-square)
[120.231970] Starting subtest: compute-square
[120.237649] Subtest compute-square: SUCCESS (0.006s)
[120.360626] [025/133] (899s left) gem_mmap (bad-size)
[120.417289] Subtest bad-size: SKIP (0.000s)
[120.485368] [026/133] (899s left) gem_exec_params (sol-reset-not-gen7)
[120.546192] Starting subtest: sol-reset-not-gen7
[120.551049] Subtest sol-reset-not-gen7: SUCCESS (0.004s)
[120.676288] [027/133] (899s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[120.773448] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[121.397560] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[121.546807] [028/133] (898s left) kms_flip (2x-plain-flip)
[121.641131] Starting subtest: 2x-plain-flip
[121.650163] Subtest 2x-plain-flip: SKIP (0.011s)
[121.727130] [029/133] (898s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[121.818029] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[121.820299] Starting dynamic subtest: pipe-A-eDP-1
[128.489592] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.674s)
[128.498413] Starting dynamic subtest: pipe-B-eDP-1
[135.625031] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.135s)
[135.627364] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.811s)
[136.477623] [030/133] (883s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[136.569024] Starting subtest: bad-pixel-format-y-tiled-ccs
[136.571302] Starting dynamic subtest: pipe-A-eDP-1
[136.594286] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.608141] Starting dynamic subtest: pipe-B-eDP-1
[136.630063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.638350] Starting dynamic subtest: pipe-C-eDP-1
[136.660173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.668068] Starting dynamic subtest: pipe-D-eDP-1
[136.690111] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.694219] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[138.844551] [031/133] (881s left) gem_spin_batch (resubmit-new)
[138.914649] Starting subtest: resubmit-new
[138.916527] Starting dynamic subtest: rcs0
[138.920982] Dynamic subtest rcs0: SUCCESS (0.007s)
[138.929778] Starting dynamic subtest: bcs0
[138.932046] Dynamic subtest bcs0: SUCCESS (0.004s)
[138.940370] Starting dynamic subtest: vcs0
[138.942245] Dynamic subtest vcs0: SUCCESS (0.004s)
[138.950421] Starting dynamic subtest: vcs1
[138.952599] Dynamic subtest vcs1: SUCCESS (0.004s)
[138.960911] Starting dynamic subtest: vecs0
[138.963137] Dynamic subtest vecs0: SUCCESS (0.005s)
[138.971070] Starting dynamic subtest: ccs0
[138.973209] Dynamic subtest ccs0: SUCCESS (0.004s)
[138.975348] Subtest resubmit-new: SUCCESS (0.032s)
[140.921576] [032/133] (879s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[141.018346] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[141.046794] Starting dynamic subtest: pipe-A-plane-0
[141.670500] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[141.688215] Starting dynamic subtest: pipe-A-plane-3
[142.079517] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[143.226910] Starting dynamic subtest: pipe-B-plane-0
[143.864994] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[143.873580] Starting dynamic subtest: pipe-B-plane-3
[144.264448] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[144.588790] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.570s)
[145.413405] [033/133] (874s left) gem_ctx_persistence (engines-hang)
[145.461922] Starting subtest: engines-hang
[145.464443] Starting dynamic subtest: rcs0
[145.574810] Dynamic subtest rcs0: SUCCESS (0.113s)
[145.586761] Starting dynamic subtest: bcs0
[145.669652] Dynamic subtest bcs0: SUCCESS (0.093s)
[145.680734] Starting dynamic subtest: vcs0
[145.766615] Dynamic subtest vcs0: SUCCESS (0.095s)
[145.778229] Starting dynamic subtest: vcs1
[145.835550] Dynamic subtest vcs1: SUCCESS (0.067s)
[145.845342] Starting dynamic subtest: vecs0
[145.949625] Dynamic subtest vecs0: SUCCESS (0.112s)
[145.961301] Starting dynamic subtest: ccs0
[146.038517] Dynamic subtest ccs0: SUCCESS (0.087s)
[146.040945] Subtest engines-hang: SUCCESS (0.578s)
[146.130880] [034/133] (874s left) kms_cursor_edge_walk (128x128-left-edge)
[146.221701] Starting subtest: 128x128-left-edge
[146.224026] Starting dynamic subtest: pipe-A-eDP-1
[149.669192] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[149.678323] Starting dynamic subtest: pipe-D-eDP-1
[152.803450] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[152.805699] Subtest 128x128-left-edge: SUCCESS (6.582s)
[153.635411] [035/133] (866s left) gem_softpin (evict-snoop)
[153.701018] Starting subtest: evict-snoop
[153.705687] Subtest evict-snoop: SKIP (0.000s)
[153.821807] [036/133] (866s left) gem_exec_reloc (basic-gtt-cpu)
[153.874966] Subtest basic-gtt-cpu: SKIP (0.000s)
[153.942232] [037/133] (866s left) i915_hangman (detector)
[154.005193] Starting subtest: detector
[154.007134] Starting dynamic subtest: rcs0
[165.875387] Dynamic subtest rcs0: SUCCESS (11.873s)
[165.887029] Starting dynamic subtest: bcs0
[177.843915] Dynamic subtest bcs0: SUCCESS (11.965s)
[177.854725] Starting dynamic subtest: vcs0
[189.875264] Dynamic subtest vcs0: SUCCESS (12.027s)
[189.889178] Starting dynamic subtest: vcs1
[200.883308] Dynamic subtest vcs1: SUCCESS (11.005s)
[200.895597] Starting dynamic subtest: vecs0
[212.852201] Dynamic subtest vecs0: SUCCESS (11.965s)
[212.865856] Starting dynamic subtest: ccs0
[224.818621] Dynamic subtest ccs0: SUCCESS (11.963s)
[224.821351] Subtest detector: SUCCESS (70.816s)
[224.902378] [038/133] (795s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[224.999895] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[225.002176] Starting dynamic subtest: pipe-A
[225.023780] Dynamic subtest pipe-A: SKIP (0.019s)
[225.032753] Starting dynamic subtest: pipe-B
[225.063556] Dynamic subtest pipe-B: SKIP (0.033s)
[225.072721] Starting dynamic subtest: pipe-C
[225.090328] Dynamic subtest pipe-C: SKIP (0.033s)
[225.099069] Starting dynamic subtest: pipe-D
[225.124580] Dynamic subtest pipe-D: SKIP (0.033s)
[225.128987] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.121s)
[225.229420] [039/133] (795s left) sw_sync (sync_merge)
[225.278358] Starting subtest: sync_merge
[225.280604] Subtest sync_merge: SUCCESS (0.000s)
[225.348234] [040/133] (795s left) gem_eio (in-flight-contexts-immediate)
[225.520015] Starting subtest: in-flight-contexts-immediate
[236.921633] Subtest in-flight-contexts-immediate: SUCCESS (11.400s)
[237.102417] [041/133] (783s left) syncobj_timeline (invalid-query-bad-pad)
[237.165326] Starting subtest: invalid-query-bad-pad
[237.167612] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[237.256468] [042/133] (783s left) drm_read (fault-buffer)
[237.396524] Starting subtest: fault-buffer
[237.398968] Subtest fault-buffer: SUCCESS (0.001s)
[237.522110] [043/133] (783s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[237.615865] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[237.618101] Starting dynamic subtest: pipe-A-default-mode
[238.766840] Dynamic subtest pipe-A-default-mode: SKIP (1.147s)
[238.771136] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.149s)
[238.913141] [044/133] (781s left) kms_draw_crc (draw-method-pwrite)
[239.010364] Starting subtest: draw-method-pwrite
[239.012300] Starting dynamic subtest: xrgb8888-untiled
[239.609479] Dynamic subtest xrgb8888-untiled: SUCCESS (0.601s)
[239.618982] Starting dynamic subtest: rgb565-untiled
[240.076930] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[240.086265] Starting dynamic subtest: xrgb2101010-untiled
[240.642868] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[240.653651] Starting dynamic subtest: xbgr16161616f-untiled
[241.409502] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.764s)
[241.419126] Starting dynamic subtest: xrgb8888-xtiled
[243.244582] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.833s)
[243.254119] Starting dynamic subtest: rgb565-xtiled
[244.376336] Dynamic subtest rgb565-xtiled: SUCCESS (1.132s)
[244.386025] Starting dynamic subtest: xrgb2101010-xtiled
[246.209652] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.832s)
[246.220614] Starting dynamic subtest: xbgr16161616f-xtiled
[249.754218] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.544s)
[249.764211] Starting dynamic subtest: xrgb8888-4tiled
[250.876381] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.121s)
[250.886090] Starting dynamic subtest: rgb565-4tiled
[251.465142] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[251.474902] Starting dynamic subtest: xrgb2101010-4tiled
[252.587409] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.122s)
[252.597074] Starting dynamic subtest: xbgr16161616f-4tiled
[255.620844] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.031s)
[255.623177] Subtest draw-method-pwrite: SUCCESS (16.613s)
[255.728455] [045/133] (764s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[255.798248] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[255.802851] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[255.981240] [046/133] (764s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[256.071095] Starting subtest: random-ccs-data-y-tiled-ccs
[256.073336] Starting dynamic subtest: pipe-A-eDP-1
[256.098053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[256.108837] Starting dynamic subtest: pipe-B-eDP-1
[256.131787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[256.140060] Starting dynamic subtest: pipe-C-eDP-1
[256.162805] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[256.171260] Starting dynamic subtest: pipe-D-eDP-1
[256.194720] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[256.199045] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.008s)
[258.403303] [047/133] (762s left) kms_psr (pr-primary-render)
[258.491629] Starting subtest: pr-primary-render
[258.495793] Subtest pr-primary-render: SKIP (0.000s)
[258.565564] [048/133] (762s left) kms_flip (plain-flip-ts-check)
[258.658073] Starting subtest: plain-flip-ts-check
[258.660337] Starting dynamic subtest: A-eDP1
[267.509717] Dynamic subtest A-eDP1: SUCCESS (8.853s)
[267.524870] Starting dynamic subtest: B-eDP1
[276.433031] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[276.445046] Starting dynamic subtest: C-eDP1
[285.252513] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[285.261577] Starting dynamic subtest: D-eDP1
[294.085414] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[294.090544] Subtest plain-flip-ts-check: SUCCESS (35.435s)
[295.262881] [049/133] (725s left) gem_mmap_gtt (basic-short)
[295.330567] Subtest basic-short: SKIP (0.000s)
[295.387134] [050/133] (725s left) gem_pxp (create-regular-buffer)
[295.512242] Starting subtest: create-regular-buffer
[295.514453] Subtest create-regular-buffer: SUCCESS (0.000s)
[295.617630] [051/133] (725s left) gem_ctx_shared (disjoint-timelines)
[295.682335] Starting subtest: disjoint-timelines
[295.711339] Subtest disjoint-timelines: SUCCESS (0.029s)
[295.955370] [052/133] (724s left) kms_addfb_basic (unused-handle)
[296.025566] Starting subtest: unused-handle
[296.027626] Subtest unused-handle: SUCCESS (0.000s)
[296.164249] [053/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[296.270344] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[303.484827] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.217s)
[303.608142] [054/133] (717s left) gem_softpin (evict-active-interruptible)
[303.675305] Starting subtest: evict-active-interruptible
[303.680703] Subtest evict-active-interruptible: SUCCESS (0.006s)
[303.792066] [055/133] (717s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[303.851093] Starting subtest: invalid-multi-wait-all-unsubmitted
[303.853348] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[303.956026] [056/133] (717s left) gem_ctx_persistence (legacy-engines-persistence)
[304.013193] Starting subtest: legacy-engines-persistence
[304.015486] Starting dynamic subtest: render
[304.785785] Dynamic subtest render: SUCCESS (0.772s)
[304.799066] Starting dynamic subtest: bsd1
[305.547050] Dynamic subtest bsd1: SUCCESS (0.757s)
[305.565405] Starting dynamic subtest: bsd2
[306.319899] Dynamic subtest bsd2: SUCCESS (0.770s)
[306.331645] Starting dynamic subtest: blt
[307.066093] Dynamic subtest blt: SUCCESS (0.743s)
[307.077173] Starting dynamic subtest: vebox
[307.854720] Dynamic subtest vebox: SUCCESS (0.786s)
[307.857170] Subtest legacy-engines-persistence: SUCCESS (3.843s)
[307.941894] [057/133] (713s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[308.041802] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[308.043985] Starting dynamic subtest: pipe-A-eDP-1
[308.101476] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[308.111828] Starting dynamic subtest: pipe-B-eDP-1
[308.167537] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[308.177654] Starting dynamic subtest: pipe-C-eDP-1
[308.231672] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[308.240931] Starting dynamic subtest: pipe-D-eDP-1
[308.295246] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[308.299085] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[310.349184] [058/133] (710s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[310.408624] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[310.513037] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[310.591785] [059/133] (710s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[310.690247] Starting subtest: primary-y-tiled-reflect-x-0
[310.751329] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[310.857451] [060/133] (710s left) kms_vblank (query-forked-hang)
[310.968759] Starting subtest: query-forked-hang
[310.970855] Starting dynamic subtest: pipe-A-eDP-1
[337.749147] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.778s)
[337.763181] Starting dynamic subtest: pipe-D-eDP-1
[362.653160] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.898s)
[362.655324] Subtest query-forked-hang: SUCCESS (51.684s)
[363.508596] [061/133] (657s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[363.609492] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[363.613751] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[363.715283] [062/133] (657s left) syncobj_timeline (host-signal-points)
[363.764943] Starting subtest: host-signal-points
[363.769797] Subtest host-signal-points: SUCCESS (0.005s)
[363.870476] [063/133] (657s left) kms_content_protection (atomic-dpms-hdcp14)
[364.008045] Starting subtest: atomic-dpms-hdcp14
[364.012255] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[364.114827] [064/133] (657s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[364.200144] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[371.071986] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.873s)
[371.209603] [065/133] (650s left) kms_psr (psr2-sprite-blt)
[371.298786] Starting subtest: psr2-sprite-blt
[371.301061] Starting dynamic subtest: eDP-1
[373.016631] Dynamic subtest eDP-1: SUCCESS (1.717s)
[373.018837] Subtest psr2-sprite-blt: SUCCESS (1.718s)
[373.886907] [066/133] (647s left) kms_prop_blob (invalid-set-prop)
[373.939221] Starting subtest: invalid-set-prop
[373.941103] Subtest invalid-set-prop: SUCCESS (0.000s)
[374.033878] [067/133] (647s left) i915_pm_rpm (system-suspend-execbuf)
[376.065189] Starting subtest: system-suspend-execbuf
[434.350233] Subtest system-suspend-execbuf: SUCCESS (42.954s)
[434.732849] [068/133] (586s left) kms_addfb_basic (size-max)
[434.840199] Starting subtest: size-max
[434.842357] Subtest size-max: SUCCESS (0.000s)
[434.946340] [069/133] (586s left) kms_cursor_crc (cursor-offscreen-64x64)
[435.135947] Starting subtest: cursor-offscreen-64x64
[435.140681] Starting dynamic subtest: pipe-A-eDP-1
[437.094391] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[437.132348] Starting dynamic subtest: pipe-D-eDP-1
[439.746990] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[439.749285] Subtest cursor-offscreen-64x64: SUCCESS (4.607s)
[440.591740] [070/133] (581s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[440.677230] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[440.681641] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[440.753238] [071/133] (580s left) drm_read (invalid-buffer)
[440.902461] Starting subtest: invalid-buffer
[440.904767] Subtest invalid-buffer: SUCCESS (0.000s)
[441.035698] [072/133] (580s left) gem_exec_schedule (preempt-engines)
[441.105766] Starting subtest: preempt-engines
[441.108054] Starting dynamic subtest: rcs0
[443.364107] Dynamic subtest rcs0: SUCCESS (2.266s)
[443.376346] Starting dynamic subtest: bcs0
[445.624011] Dynamic subtest bcs0: SUCCESS (2.257s)
[445.636232] Starting dynamic subtest: vcs0
[447.906373] Dynamic subtest vcs0: SUCCESS (2.280s)
[447.919310] Starting dynamic subtest: vcs1
[450.203186] Dynamic subtest vcs1: SUCCESS (2.294s)
[450.216578] Starting dynamic subtest: vecs0
[452.485200] Dynamic subtest vecs0: SUCCESS (2.280s)
[452.502366] Starting dynamic subtest: ccs0
[454.858702] Dynamic subtest ccs0: SUCCESS (2.371s)
[454.861501] Subtest preempt-engines: SUCCESS (13.760s)
[455.166237] [073/133] (566s left) gen7_exec_parse (bitmasks)
[455.242717] Subtest bitmasks: SKIP (0.000s)
[455.309747] [074/133] (566s left) kms_scaling_modes (scaling-mode-none)
[455.413238] Starting subtest: scaling-mode-none
[455.416034] Starting dynamic subtest: pipe-A-eDP-1
[455.506851] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[455.523389] Starting dynamic subtest: pipe-B-eDP-1
[455.546206] Dynamic subtest pipe-B-eDP-1: SKIP (0.037s)
[455.558408] Starting dynamic subtest: pipe-C-eDP-1
[455.578628] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[455.588791] Starting dynamic subtest: pipe-D-eDP-1
[455.617228] Dynamic subtest pipe-D-eDP-1: SKIP (0.036s)
[455.621780] Subtest scaling-mode-none: SKIP (0.205s)
[455.731388] [075/133] (566s left) i915_selftest (live)
[457.481188] Starting subtest: live
[457.486189] Starting dynamic subtest: sanitycheck
[461.856496] Dynamic subtest sanitycheck: SUCCESS (4.373s)
[461.871555] Starting dynamic subtest: uncore
[466.208374] Dynamic subtest uncore: SUCCESS (4.348s)
[466.218356] Starting dynamic subtest: workarounds
[484.143292] Dynamic subtest workarounds: FAIL (17.787s)
[484.152334] Starting dynamic subtest: gt_engines
[487.031967] Dynamic subtest gt_engines: SUCCESS (3.029s)
[487.042334] Starting dynamic subtest: gt_timelines
[504.701953] Dynamic subtest gt_timelines: SUCCESS (17.665s)
[504.712094] Starting dynamic subtest: gt_contexts
[509.016192] Dynamic subtest gt_contexts: SUCCESS (4.312s)
[509.026479] Starting dynamic subtest: gt_lrc
[513.350228] Dynamic subtest gt_lrc: SUCCESS (4.332s)
[513.360050] Starting dynamic subtest: gt_mocs
[517.774927] Dynamic subtest gt_mocs: SUCCESS (4.424s)
[517.784069] Starting dynamic subtest: gt_pm
[524.558553] Dynamic subtest gt_pm: SUCCESS (6.781s)
[524.568795] Starting dynamic subtest: gt_heartbeat
[528.837811] Dynamic subtest gt_heartbeat: SUCCESS (4.278s)
[528.847704] Starting dynamic subtest: gt_tlb
[538.148492] Dynamic subtest gt_tlb: SUCCESS (9.309s)
[538.159404] Starting dynamic subtest: requests
[551.584874] Dynamic subtest requests: SUCCESS (13.434s)
[551.594555] Starting dynamic subtest: migrate
[557.328045] Dynamic subtest migrate: SUCCESS (5.740s)
[557.341307] Starting dynamic subtest: active
[561.708987] Dynamic subtest active: SUCCESS (4.379s)
[561.717763] Starting dynamic subtest: objects
[566.405138] Dynamic subtest objects: SUCCESS (4.694s)
[566.415353] Starting dynamic subtest: mman
[571.189441] Dynamic subtest mman: SUCCESS (4.783s)
[571.199572] Starting dynamic subtest: dmabuf
[575.516034] Dynamic subtest dmabuf: SUCCESS (4.324s)
[575.526548] Starting dynamic subtest: vma
[579.837454] Dynamic subtest vma: SUCCESS (4.319s)
[579.847412] Starting dynamic subtest: coherency
[583.262351] Dynamic subtest coherency: SUCCESS (3.423s)
[583.272754] Starting dynamic subtest: gtt
[593.164837] Dynamic subtest gtt: SUCCESS (9.901s)
[593.174697] Starting dynamic subtest: gem
[598.968465] Dynamic subtest gem: SUCCESS (5.802s)
[598.978502] Starting dynamic subtest: evict
[604.467564] Dynamic subtest evict: SUCCESS (5.496s)
[604.477611] Starting dynamic subtest: hugepages
[613.353795] Dynamic subtest hugepages: SUCCESS (8.884s)
[613.364955] Starting dynamic subtest: gem_contexts
[641.635734] Dynamic subtest gem_contexts: SUCCESS (28.279s)
[641.645742] Starting dynamic subtest: client
[645.995025] Dynamic subtest client: SUCCESS (4.358s)
[646.005213] Starting dynamic subtest: gem_migrate
[650.354540] Dynamic subtest gem_migrate: SUCCESS (4.358s)
[650.370792] Starting dynamic subtest: reset
[653.133321] Dynamic subtest reset: SUCCESS (2.776s)
[653.143291] Starting dynamic subtest: memory_region
[657.492745] Dynamic subtest memory_region: SUCCESS (4.358s)
[657.503142] Starting dynamic subtest: hangcheck
[670.660436] Dynamic subtest hangcheck: SUCCESS (13.167s)
[670.670833] Starting dynamic subtest: execlists
[675.033604] Dynamic subtest execlists: SUCCESS (4.371s)
[675.041545] Starting dynamic subtest: ring_submission
[679.358859] Dynamic subtest ring_submission: SUCCESS (4.323s)
[679.367473] Starting dynamic subtest: perf
[683.654379] Dynamic subtest perf: SUCCESS (4.293s)
[683.664535] Starting dynamic subtest: slpc
[697.738822] Dynamic subtest slpc: SUCCESS (14.083s)
[697.749165] Starting dynamic subtest: guc
[701.676278] Dynamic subtest guc: SUCCESS (3.935s)
[701.685731] Starting dynamic subtest: guc_multi_lrc
[705.976693] Dynamic subtest guc_multi_lrc: SUCCESS (4.299s)
[705.986820] Starting dynamic subtest: guc_hang
[710.882296] Dynamic subtest guc_hang: SUCCESS (4.904s)
[710.891693] Starting dynamic subtest: late_gt_pm
[715.197190] Dynamic subtest late_gt_pm: SUCCESS (4.312s)
[715.199771] Subtest live: FAIL (257.700s)
[715.229137] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[715.229825] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[715.232848] [076/133] (306s left) kms_chamelium_edid (dp-edid-read)
[717.028420] Subtest dp-edid-read: SKIP (0.000s)
[717.867394] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[717.868609] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[717.872235] [077/133] (304s left) gem_exercise_blt (fast-copy-emit)
[717.938622] Starting subtest: fast-copy-emit
[717.940827] Starting dynamic subtest: linear-smem-smem-emit
[717.960841] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.025s)
[717.971284] Starting dynamic subtest: xmajor-smem-smem-emit
[717.980143] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[717.988680] Starting dynamic subtest: tile4-smem-smem-emit
[717.997402] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[718.006060] Starting dynamic subtest: tile64-smem-smem-emit
[718.015490] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[718.017673] Subtest fast-copy-emit: SUCCESS (0.080s)
[718.129931] [078/133] (303s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[718.238983] Starting subtest: x-tiled-8bpp-rotate-180
[719.476565] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.237s)
[719.610896] [079/133] (302s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[719.700966] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[719.704842] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[719.773694] [080/133] (302s left) kms_lease (atomic-implicit-crtc)
[719.864843] Starting subtest: atomic-implicit-crtc
[719.867063] Starting dynamic subtest: pipe-A-eDP-1
[719.877788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[719.890746] Starting dynamic subtest: pipe-B-eDP-1
[719.900403] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[719.911201] Starting dynamic subtest: pipe-C-eDP-1
[719.920031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[719.928428] Starting dynamic subtest: pipe-D-eDP-1
[719.937261] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[719.939038] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[719.989822] [081/133] (302s left) api_intel_allocator (standalone)
[720.041276] Starting subtest: standalone
[720.054345] Subtest standalone: SUCCESS (0.015s)
[720.185701] [082/133] (301s left) fbdev (unaligned-write)
[720.223141] Starting subtest: unaligned-write
[720.326144] Subtest unaligned-write: SUCCESS (0.100s)
[720.387898] [083/133] (301s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[720.485808] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[720.489833] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[720.583164] [084/133] (301s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[720.693389] Starting subtest: fbcpsr-1p-rte
[727.749901] Subtest fbcpsr-1p-rte: SUCCESS (7.060s)
[727.902153] [085/133] (294s left) kms_addfb_basic (master-rmfb)
[727.968549] Starting subtest: master-rmfb
[727.970946] Subtest master-rmfb: SUCCESS (0.001s)
[728.092010] [086/133] (294s left) syncobj_timeline (multi-wait-signaled)
[728.144422] Starting subtest: multi-wait-signaled
[728.146653] Subtest multi-wait-signaled: SUCCESS (0.000s)
[728.248983] [087/133] (294s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[728.350592] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[728.354809] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[728.475885] [088/133] (293s left) kms_atomic_transition (modeset-transition)
[728.577417] Starting subtest: modeset-transition
[728.579623] Starting dynamic subtest: 1x-outputs
[739.436441] Dynamic subtest 1x-outputs: SUCCESS (10.859s)
[739.438974] Subtest modeset-transition: SUCCESS (10.861s)
[740.286027] [089/133] (282s left) gem_exec_whisper (basic-normal-all)
[740.351625] Starting subtest: basic-normal-all
[742.630015] Subtest basic-normal-all: SUCCESS (2.276s)
[742.821407] [090/133] (279s left) gem_wait (wait)
[742.879602] Starting subtest: wait
[742.882002] Starting dynamic subtest: all-engines
[744.241861] Dynamic subtest all-engines: SUCCESS (1.360s)
[744.254508] Starting dynamic subtest: rcs0
[745.289172] Dynamic subtest rcs0: SUCCESS (1.046s)
[745.300609] Starting dynamic subtest: bcs0
[746.336029] Dynamic subtest bcs0: SUCCESS (1.045s)
[746.347769] Starting dynamic subtest: vcs0
[747.381499] Dynamic subtest vcs0: SUCCESS (1.043s)
[747.393276] Starting dynamic subtest: vcs1
[748.426957] Dynamic subtest vcs1: SUCCESS (1.043s)
[748.438238] Starting dynamic subtest: vecs0
[749.472060] Dynamic subtest vecs0: SUCCESS (1.042s)
[749.483840] Starting dynamic subtest: ccs0
[750.519019] Dynamic subtest ccs0: SUCCESS (1.045s)
[750.521721] Subtest wait: SUCCESS (7.640s)
[750.732654] [091/133] (271s left) kms_pipe_crc_basic (nonblocking-crc)
[750.821618] Starting subtest: nonblocking-crc
[750.823952] Starting dynamic subtest: pipe-A-eDP-1
[751.574299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[751.584556] Starting dynamic subtest: pipe-B-eDP-1
[753.012637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[753.022413] Starting dynamic subtest: pipe-C-eDP-1
[754.383901] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[754.394263] Starting dynamic subtest: pipe-D-eDP-1
[755.699799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[755.702262] Subtest nonblocking-crc: SUCCESS (4.880s)
[756.508282] [092/133] (266s left) vgem_basic (bad-pad)
[756.561389] Starting subtest: bad-pad
[756.563747] Subtest bad-pad: SUCCESS (0.000s)
[756.631798] [093/133] (266s left) gem_exec_fence (invalid-timeline-fence-array)
[757.165843] Starting subtest: invalid-timeline-fence-array
[757.172336] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[758.341921] [094/133] (264s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[758.449355] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[762.719031] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.273s)
[763.931743] [095/133] (258s left) gem_exec_fence (syncobj-timeline-unused-fence)
[764.446188] Starting subtest: syncobj-timeline-unused-fence
[764.452920] Subtest syncobj-timeline-unused-fence: SUCCESS (0.008s)
[766.337296] [096/133] (256s left) kms_color (ctm-green-to-red)
[766.438046] Starting subtest: ctm-green-to-red
[766.440191] Starting dynamic subtest: pipe-A-eDP-1
[767.151125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[767.161059] Starting dynamic subtest: pipe-B-eDP-1
[768.567828] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[768.577995] Starting dynamic subtest: pipe-C-eDP-1
[769.897748] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.329s)
[769.908072] Starting dynamic subtest: pipe-D-eDP-1
[771.252703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[771.255018] Subtest ctm-green-to-red: SUCCESS (4.815s)
[772.050922] [097/133] (250s left) prime_vgem (basic-fence-flip)
[772.123228] Starting subtest: basic-fence-flip
[772.413423] Subtest basic-fence-flip: SUCCESS (0.290s)
[772.533936] [098/133] (250s left) perf (non-zero-reason)
[772.682655] Starting subtest: non-zero-reason
[772.684819] Starting dynamic subtest: 0-rcs0
[778.103727] Dynamic subtest 0-rcs0: SUCCESS (5.419s)
[778.116452] Starting dynamic subtest: 1-vcs0
[782.014972] Dynamic subtest 1-vcs0: SUCCESS (3.910s)
[782.017873] Subtest non-zero-reason: SUCCESS (9.331s)
[782.064933] [099/133] (240s left) gem_exec_balancer (nohangcheck)
[782.330791] Starting subtest: nohangcheck
[783.256920] Subtest nohangcheck: SUCCESS (0.925s)
[783.388347] [100/133] (239s left) syncobj_wait (invalid-reset-one-illegal-handle)
[783.436969] Starting subtest: invalid-reset-one-illegal-handle
[783.438909] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[783.541931] [101/133] (239s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[783.639025] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[790.594886] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.956s)
[790.732918] [102/133] (232s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[790.836356] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[790.840718] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[790.942602] [103/133] (232s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[791.004819] Starting subtest: x-tiled-to-vebox-y-tiled
[791.009182] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[791.193133] [104/133] (231s left) gem_exec_nop (basic-series)
[791.265084] Starting subtest: basic-series
[807.219804] Subtest basic-series: SUCCESS (15.961s)
[807.454371] [105/133] (215s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[807.559363] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[807.561662] Starting dynamic subtest: pipe-A-eDP-1
[807.583878] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[807.595851] Starting dynamic subtest: pipe-B-eDP-1
[807.615980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[807.624605] Starting dynamic subtest: pipe-C-eDP-1
[807.644792] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[807.653516] Starting dynamic subtest: pipe-D-eDP-1
[807.674216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[807.678218] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[809.824991] [106/133] (213s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[809.931746] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[809.935736] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[810.022039] [107/133] (213s left) kms_flip (bo-too-big)
[810.119962] Starting subtest: bo-too-big
[810.122274] Starting dynamic subtest: A-eDP1
[811.476352] Dynamic subtest A-eDP1: SUCCESS (1.356s)
[811.488205] Starting dynamic subtest: B-eDP1
[812.804484] Dynamic subtest B-eDP1: SUCCESS (1.325s)
[812.815470] Starting dynamic subtest: C-eDP1
[814.147436] Dynamic subtest C-eDP1: SUCCESS (1.342s)
[814.160628] Starting dynamic subtest: D-eDP1
[815.475921] Dynamic subtest D-eDP1: SUCCESS (1.326s)
[815.478392] Subtest bo-too-big: SUCCESS (5.359s)
[816.684201] [108/133] (206s left) gem_exec_await (wide-all)
[816.891419] Starting subtest: wide-all
[840.095549] Subtest wide-all: SUCCESS (23.200s)
[840.297396] [109/133] (183s left) perf (oa-exponents)
[840.456628] Starting subtest: oa-exponents
[840.458987] Starting dynamic subtest: 0-rcs0
[842.249374] Dynamic subtest 0-rcs0: SUCCESS (1.790s)
[842.261021] Starting dynamic subtest: 1-vcs0
[844.077415] Dynamic subtest 1-vcs0: SUCCESS (1.827s)
[844.080227] Subtest oa-exponents: SUCCESS (3.619s)
[844.129057] [110/133] (179s left) template (b)
[844.203656] Starting subtest: B
[844.206213] Subtest B: SUCCESS (0.000s)
[844.317445] [111/133] (179s left) kms_getfb (getfb-repeated-different-handles)
[844.414676] Starting subtest: getfb-repeated-different-handles
[844.416814] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[844.519757] [112/133] (178s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[844.611061] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[851.988293] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.380s)
[852.115060] [113/133] (171s left) kms_cursor_crc (cursor-sliding-128x42)
[852.343018] Starting subtest: cursor-sliding-128x42
[852.392672] Subtest cursor-sliding-128x42: SKIP (0.044s)
[852.579043] [114/133] (170s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[852.677127] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[861.209306] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.534s)
[861.321211] [115/133] (162s left) kms_dp_link_training (non-uhbr-mst)
[861.418656] Starting subtest: non-uhbr-mst
[861.427134] Subtest non-uhbr-mst: SKIP (0.000s)
[861.490426] [116/133] (162s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[861.566893] Starting subtest: stress-mm-invalidate-close-overlap
[863.715759] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[863.844963] [117/133] (159s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[865.412306] Starting subtest: modeset-lpsp-stress-no-wait
[875.525253] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.117s)
[875.615958] [118/133] (148s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[875.713193] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[880.258696] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.548s)
[881.391339] [119/133] (142s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[881.494844] Starting subtest: psr-rgb565-draw-mmap-wc
[888.311016] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.819s)
[888.410085] [120/133] (135s left) gem_userptr_blits (process-exit)
[888.487182] Starting subtest: process-exit
[888.497358] Subtest process-exit: SUCCESS (0.009s)
[888.607541] [121/133] (135s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[888.703342] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[888.707742] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[888.774607] [122/133] (135s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[888.860952] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[888.863231] Starting dynamic subtest: pipe-A
[888.974951] Dynamic subtest pipe-A: SKIP (0.108s)
[888.996800] Starting dynamic subtest: pipe-B
[890.178988] Dynamic subtest pipe-B: SKIP (1.202s)
[890.200062] Starting dynamic subtest: pipe-C
[891.320921] Dynamic subtest pipe-C: SUCCESS (1.149s)
[891.330868] Starting dynamic subtest: pipe-D
[892.581377] Dynamic subtest pipe-D: SUCCESS (1.259s)
[892.583795] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.723s)
[893.771624] [123/133] (130s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[893.831028] Starting subtest: invalid-single-wait-all-unsubmitted
[893.832957] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[893.925152] [124/133] (130s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[894.055843] Starting subtest: yf-tiled-16bpp-rotate-0
[894.060145] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[894.156570] [125/133] (129s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[894.247298] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[895.027115] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[895.192666] [126/133] (128s left) kms_flip (2x-flip-vs-suspend)
[895.278860] Starting subtest: 2x-flip-vs-suspend
[895.283197] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[895.398292] [127/133] (128s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[895.505625] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[902.315858] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.813s)
[902.453689] [128/133] (121s left) core_auth (getclient-simple)
[902.494295] Starting subtest: getclient-simple
[902.523697] Subtest getclient-simple: SUCCESS (0.030s)
[902.637512] [129/133] (121s left) perf_pmu (multi-client)
[902.675730] Starting subtest: multi-client
[902.678289] Starting dynamic subtest: rcs0
[903.740106] Dynamic subtest rcs0: SUCCESS (1.065s)
[903.752366] Starting dynamic subtest: bcs0
[904.789554] Dynamic subtest bcs0: SUCCESS (1.047s)
[904.803448] Starting dynamic subtest: vcs0
[905.840075] Dynamic subtest vcs0: SUCCESS (1.047s)
[905.859905] Starting dynamic subtest: vcs1
[907.245325] Dynamic subtest vcs1: SUCCESS (1.401s)
[907.258022] Starting dynamic subtest: vecs0
[909.230819] Dynamic subtest vecs0: SUCCESS (1.982s)
[909.242911] Starting dynamic subtest: ccs0
[911.271199] Dynamic subtest ccs0: SUCCESS (2.038s)
[911.274422] Subtest multi-client: SUCCESS (8.597s)
[911.390434] [130/133] (112s left) syncobj_wait (wait-for-submit-delayed-submit)
[911.449657] Starting subtest: wait-for-submit-delayed-submit
[911.551510] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[911.632141] [131/133] (112s left) gem_exec_suspend (basic-s3)
[911.693156] Starting subtest: basic-S3
[911.695680] Starting dynamic subtest: smem
[932.738309] Dynamic subtest smem: SUCCESS (7.521s)
[932.741360] Subtest basic-S3: SUCCESS (7.524s)
[936.966142] [132/133] ( 91s left) device_reset (cold-reset-bound)
[937.032939] Starting subtest: cold-reset-bound
[937.037485] Subtest cold-reset-bound: SKIP (0.000s)
[937.106466] [133/133] ( 91s left) kms_psr (fbc-pr-sprite-blt)
[937.198883] Starting subtest: fbc-pr-sprite-blt
[937.203197] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[937.270180] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: prime_mmap_coherency
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_compute
results: parsing output: 24/ for test: gem_mmap
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_spin_batch
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: sw_sync
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: drm_read
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_draw_crc
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: gem_ctx_shared
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_prop_blob
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: drm_read
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gen7_exec_parse
results: parsing output: 73/ for test: kms_scaling_modes
results: parsing output: 74/ for test: i915_selftest
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: gem_exercise_blt
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic_transition
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: gem_wait
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gem_exec_balancer
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gem_exec_nop
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_await
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: template
results: parsing output: 110/ for test: kms_getfb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_dp_link_training
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: core_auth
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: gem_exec_suspend
results: parsing output: 131/ for test: device_reset
results: parsing output: 132/ for test: kms_psr
Done.