[61.821411] Initializing watchdogs
[61.821459]   /dev/watchdog0
[61.835903] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.840012] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.842270] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.845614] [001/134] (960s left) gem_mmap_gtt (basic-short)
[61.943144] Subtest basic-short: SKIP (0.000s)
[62.007506] [002/134] (960s left) kms_plane (plane-panning-bottom-right-suspend)
[62.119817] Starting subtest: plane-panning-bottom-right-suspend
[62.122073] Starting dynamic subtest: pipe-A
[79.931040] Dynamic subtest pipe-A: SUCCESS (3.069s)
[79.940197] Starting dynamic subtest: pipe-B
[98.912303] Dynamic subtest pipe-B: SUCCESS (3.716s)
[98.914676] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.787s)
[99.716431] [003/134] (922s left) kms_big_fb (linear-8bpp-rotate-180)
[99.815190] Starting subtest: linear-8bpp-rotate-180
[101.104851] Subtest linear-8bpp-rotate-180: SUCCESS (1.291s)
[101.270468] [004/134] (921s left) prime_mmap (test_correct)
[101.327795] Starting subtest: test_correct
[101.329481] Starting dynamic subtest: test_correct-smem
[101.355856] Dynamic subtest test_correct-smem: SUCCESS (0.029s)
[101.357974] Subtest test_correct: SUCCESS (0.030s)
[101.491352] [005/134] (921s left) syncobj_timeline (wait-all-for-submit-complex)
[101.551256] Starting subtest: wait-all-for-submit-complex
[101.765692] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[101.862655] [006/134] (920s left) gem_exec_parallel (fds)
[101.925022] Starting subtest: fds
[101.927447] Starting dynamic subtest: rcs0
[104.975124] Dynamic subtest rcs0: SUCCESS (3.048s)
[104.985768] Starting dynamic subtest: bcs0
[108.355147] Dynamic subtest bcs0: SUCCESS (3.380s)
[108.364610] Starting dynamic subtest: vcs0
[112.186563] Dynamic subtest vcs0: SUCCESS (3.830s)
[112.197711] Starting dynamic subtest: vcs1
[116.211089] Dynamic subtest vcs1: SUCCESS (4.024s)
[116.221726] Starting dynamic subtest: vecs0
[120.342744] Dynamic subtest vecs0: SUCCESS (4.132s)
[120.353687] Starting dynamic subtest: ccs0
[123.779519] Dynamic subtest ccs0: SUCCESS (3.436s)
[123.782303] Subtest fds: SUCCESS (21.855s)
[123.984089] [007/134] (898s left) fbdev (nullptr)
[124.044452] Starting subtest: nullptr
[124.046723] Subtest nullptr: SUCCESS (0.000s)
[124.112634] [008/134] (898s left) dmabuf_sync_file (export-before-signal)
[124.237928] Starting subtest: export-before-signal
[124.239942] Subtest export-before-signal: SUCCESS (0.001s)
[124.307641] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[124.310633] [009/134] (898s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[124.405272] Starting subtest: basic-modeset-with-all-modifiers-formats
[124.777437] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[125.591980] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.816s)
[125.606706] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[125.612811] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[125.624331] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[125.634945] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[125.647336] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[125.801775] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[125.810815] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[125.823961] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[125.832216] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[125.846115] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[125.854186] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[125.868375] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[125.876069] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[125.890534] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[125.898305] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[125.912757] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[125.920300] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[125.934893] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[125.942895] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[125.957179] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[125.965668] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[125.979541] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[125.989664] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[126.135145] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[126.147003] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[126.157182] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[126.169732] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[126.179455] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[126.191370] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[126.201667] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[126.211449] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[126.223725] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[126.231780] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[126.245998] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[126.253626] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[126.268286] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[126.276307] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[126.290530] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[126.298325] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[126.312749] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[126.323066] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[126.479802] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.167s)
[126.489707] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[126.501867] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[126.509562] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[126.524239] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[126.532031] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[126.546449] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[126.554184] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[126.568324] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[126.577395] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[126.590180] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[126.598558] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[126.612791] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[126.620237] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[126.635128] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[126.642889] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[126.656979] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[127.036854] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.633s)
[127.863084] [010/134] (894s left) kms_psr (psr-sprite-plane-onoff)
[127.969421] Starting subtest: psr-sprite-plane-onoff
[127.971628] Starting dynamic subtest: eDP-1
[129.722889] Dynamic subtest eDP-1: SUCCESS (1.755s)
[129.725131] Subtest psr-sprite-plane-onoff: SUCCESS (1.755s)
[130.547029] [011/134] (892s left) gem_media_vme
[130.691190] [012/134] (892s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[130.798719] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[136.012170] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.217s)
[137.159113] [013/134] (885s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[137.243668] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[137.246077] Starting dynamic subtest: pipe-A-default-mode
[137.542593] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[137.547542] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.300s)
[138.393694] [014/134] (884s left) i915_drm_fdinfo (virtual-idle)
[138.436400] Starting subtest: virtual-idle
[141.523853] Subtest virtual-idle: SUCCESS (3.087s)
[141.612744] [015/134] (881s left) kms_properties (colorop-properties-atomic)
[141.707507] Starting subtest: colorop-properties-atomic
[141.709469] Starting dynamic subtest: pipe-A-eDP-1
[142.050552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.343s)
[142.060379] Starting dynamic subtest: pipe-B-eDP-1
[143.133799] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.080s)
[143.143252] Starting dynamic subtest: pipe-C-eDP-1
[144.166714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[144.177960] Starting dynamic subtest: pipe-D-eDP-1
[145.204001] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.035s)
[145.206256] Subtest colorop-properties-atomic: SUCCESS (3.496s)
[146.017979] [016/134] (876s left) gem_ctx_engines (execute-allforone)
[146.082339] Starting subtest: execute-allforone
[146.094045] Subtest execute-allforone: SUCCESS (0.014s)
[148.017248] [017/134] (874s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[148.138700] Starting subtest: cursorB-vs-flipB-atomic
[148.143222] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[148.294926] [018/134] (874s left) gem_exec_params (invalid-ring)
[148.352725] Starting subtest: invalid-ring
[148.354997] Subtest invalid-ring: SUCCESS (0.000s)
[148.470282] [019/134] (874s left) perf_pmu (busy-idle)
[148.509544] Starting subtest: busy-idle
[148.511742] Starting dynamic subtest: rcs0
[149.221951] Dynamic subtest rcs0: SUCCESS (0.713s)
[149.232063] Starting dynamic subtest: bcs0
[149.896962] Dynamic subtest bcs0: SUCCESS (0.674s)
[149.908109] Starting dynamic subtest: vcs0
[151.948538] Dynamic subtest vcs0: SUCCESS (2.049s)
[151.959314] Starting dynamic subtest: vcs1
[153.932875] Dynamic subtest vcs1: SUCCESS (1.982s)
[153.944243] Starting dynamic subtest: vecs0
[155.917005] Dynamic subtest vecs0: SUCCESS (1.982s)
[155.928421] Starting dynamic subtest: ccs0
[156.588812] Dynamic subtest ccs0: SUCCESS (0.672s)
[156.591363] Subtest busy-idle: SUCCESS (8.081s)
[156.692166] [020/134] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[156.801853] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[160.394725] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.597s)
[161.543862] [021/134] (861s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[161.658653] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[162.659083] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s)
[162.808259] [022/134] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[162.919087] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[169.443792] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.528s)
[169.595577] [023/134] (853s left) gem_wait (wait)
[169.662891] Starting subtest: wait
[169.665359] Starting dynamic subtest: all-engines
[170.892304] Dynamic subtest all-engines: SUCCESS (1.227s)
[170.903441] Starting dynamic subtest: rcs0
[171.934939] Dynamic subtest rcs0: SUCCESS (1.042s)
[171.945561] Starting dynamic subtest: bcs0
[172.983554] Dynamic subtest bcs0: SUCCESS (1.047s)
[172.995008] Starting dynamic subtest: vcs0
[174.027973] Dynamic subtest vcs0: SUCCESS (1.042s)
[174.039155] Starting dynamic subtest: vcs1
[175.072549] Dynamic subtest vcs1: SUCCESS (1.043s)
[175.083468] Starting dynamic subtest: vecs0
[176.117767] Dynamic subtest vecs0: SUCCESS (1.043s)
[176.128659] Starting dynamic subtest: ccs0
[177.164267] Dynamic subtest ccs0: SUCCESS (1.045s)
[177.166981] Subtest wait: SUCCESS (7.502s)
[177.386117] [024/134] (845s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[177.484783] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[177.495842] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[177.582398] [025/134] (845s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[177.644784] Starting subtest: yf-tiled-ccs-to-y-tiled
[177.649225] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[177.838447] [026/134] (845s left) kms_pm_rpm (modeset-non-lpsp-stress)
[180.064430] Starting subtest: modeset-non-lpsp-stress
[181.219703] Subtest modeset-non-lpsp-stress: SKIP (1.156s)
[181.626444] [027/134] (841s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[181.724708] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[181.726575] Starting dynamic subtest: pipe-A-eDP-1
[182.556657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[182.570100] Starting dynamic subtest: pipe-B-eDP-1
[184.102006] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s)
[184.111904] Starting dynamic subtest: pipe-C-eDP-1
[185.614828] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.512s)
[185.624811] Starting dynamic subtest: pipe-D-eDP-1
[187.051256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[187.053467] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.319s)
[188.242732] [028/134] (835s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[188.353525] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[188.357770] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.473755] [029/134] (834s left) sw_sync (alloc_timeline)
[188.509467] Starting subtest: alloc_timeline
[188.512067] Subtest alloc_timeline: SUCCESS (0.000s)
[188.575535] [030/134] (834s left) gem_fence_thrash (bo-write-verify-threaded-none)
[188.609500] Starting subtest: bo-write-verify-threaded-none
[188.634962] Subtest bo-write-verify-threaded-none: SKIP (0.023s)
[188.695085] [031/134] (834s left) kms_busy (extended-modeset-hang-newfb)
[188.798674] Starting subtest: extended-modeset-hang-newfb
[188.800887] Starting dynamic subtest: pipe-A
[222.809594] Dynamic subtest pipe-A: SUCCESS (34.005s)
[222.818080] Starting dynamic subtest: pipe-D
[245.771630] Dynamic subtest pipe-D: SUCCESS (22.956s)
[245.773924] Subtest extended-modeset-hang-newfb: SUCCESS (56.966s)
[246.576148] [032/134] (777s left) kms_atomic (plane-primary-legacy)
[246.673802] Starting subtest: plane-primary-legacy
[246.675985] Starting dynamic subtest: pipe-A-eDP-1
[247.125671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[247.127993] Subtest plane-primary-legacy: SUCCESS (0.452s)
[248.031375] [033/134] (775s left) gem_exec_reloc (basic-write-read-noreloc)
[248.106963] Subtest basic-write-read-noreloc: SKIP (0.000s)
[248.187867] [034/134] (775s left) gem_exec_parallel (userptr)
[248.250576] Starting subtest: userptr
[248.252880] Starting dynamic subtest: rcs0
[249.670686] Dynamic subtest rcs0: SUCCESS (1.420s)
[249.681666] Starting dynamic subtest: bcs0
[251.166109] Dynamic subtest bcs0: SUCCESS (1.493s)
[251.178102] Starting dynamic subtest: vcs0
[252.894909] Dynamic subtest vcs0: SUCCESS (1.725s)
[252.906868] Starting dynamic subtest: vcs1
[254.924071] Dynamic subtest vcs1: SUCCESS (2.026s)
[254.933586] Starting dynamic subtest: vecs0
[256.907579] Dynamic subtest vecs0: SUCCESS (1.981s)
[256.917548] Starting dynamic subtest: ccs0
[258.391999] Dynamic subtest ccs0: SUCCESS (1.483s)
[258.394411] Subtest userptr: SUCCESS (10.142s)
[258.595278] [035/134] (765s left) syncobj_wait (invalid-signal-illegal-handle)
[258.653668] Starting subtest: invalid-signal-illegal-handle
[258.655990] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[258.779031] [036/134] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[258.879933] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[258.884016] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[259.024865] [037/134] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[259.127649] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[263.590475] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.466s)
[264.734317] [038/134] (759s left) perf_pmu (enable-race)
[264.781559] Starting subtest: enable-race
[264.783957] Starting dynamic subtest: rcs0
[277.553393] Dynamic subtest rcs0: SUCCESS (12.771s)
[277.562567] Starting dynamic subtest: bcs0
[290.293626] Dynamic subtest bcs0: SUCCESS (12.737s)
[290.302255] Starting dynamic subtest: vcs0
[305.931621] Dynamic subtest vcs0: SUCCESS (15.635s)
[305.941660] Starting dynamic subtest: vcs1
[321.932009] Dynamic subtest vcs1: SUCCESS (15.997s)
[321.941845] Starting dynamic subtest: vecs0
[337.867807] Dynamic subtest vecs0: SUCCESS (15.932s)
[337.878203] Starting dynamic subtest: ccs0
[350.634456] Dynamic subtest ccs0: SUCCESS (12.765s)
[350.637139] Subtest enable-race: SUCCESS (85.851s)
[350.767383] [039/134] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[350.859956] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[350.864054] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[350.965359] [040/134] (672s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[351.068581] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[351.070868] Starting dynamic subtest: pipe-A-default-mode
[351.359217] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[351.363908] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.288s)
[352.245415] [041/134] (671s left) kms_color (ctm-blue-to-red)
[352.347085] Starting subtest: ctm-blue-to-red
[352.348944] Starting dynamic subtest: pipe-A-eDP-1
[353.025812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.683s)
[353.034951] Starting dynamic subtest: pipe-B-eDP-1
[354.362010] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[354.373841] Starting dynamic subtest: pipe-C-eDP-1
[355.648549] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[355.658301] Starting dynamic subtest: pipe-D-eDP-1
[356.973339] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[356.975681] Subtest ctm-blue-to-red: SUCCESS (4.633s)
[357.821170] [042/134] (666s left) kms_chamelium_frames (hdmi-aspect-ratio)
[358.201120] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[359.014793] [043/134] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[359.126054] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[359.130302] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[359.248495] [044/134] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[359.350541] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[363.053716] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.708s)
[364.280720] [045/134] (659s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[364.394864] Starting subtest: plane-upscale-20x20-with-modifiers
[364.397154] Starting dynamic subtest: pipe-A
[364.729942] Dynamic subtest pipe-A: SUCCESS (0.337s)
[364.739427] Starting dynamic subtest: pipe-B
[366.137380] Dynamic subtest pipe-B: SUCCESS (1.406s)
[366.146931] Starting dynamic subtest: pipe-C
[367.567307] Dynamic subtest pipe-C: SUCCESS (1.429s)
[367.578116] Starting dynamic subtest: pipe-D
[368.988547] Dynamic subtest pipe-D: SUCCESS (1.420s)
[368.990804] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.597s)
[370.176855] [046/134] (654s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[370.279272] Starting subtest: fbc-rgb565-draw-render
[374.443392] Subtest fbc-rgb565-draw-render: SUCCESS (4.168s)
[375.591357] [047/134] (648s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[375.698810] Starting subtest: read-crc-frame-sequence
[375.700737] Starting dynamic subtest: pipe-A-eDP-1
[376.399958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[376.410034] Starting dynamic subtest: pipe-B-eDP-1
[377.738940] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[377.748852] Starting dynamic subtest: pipe-C-eDP-1
[379.115771] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[379.125148] Starting dynamic subtest: pipe-D-eDP-1
[380.450684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[380.453016] Subtest read-crc-frame-sequence: SUCCESS (4.753s)
[381.306119] [048/134] (642s left) gem_tiled_blits (basic)
[381.373415] Subtest basic: SKIP (0.000s)
[381.459845] [049/134] (642s left) gem_exec_fence (basic-busy)
[381.640758] Starting subtest: basic-busy
[381.643106] Starting dynamic subtest: rcs0
[381.708696] Dynamic subtest rcs0: SUCCESS (0.068s)
[381.719535] Starting dynamic subtest: bcs0
[381.765848] Dynamic subtest bcs0: SUCCESS (0.055s)
[381.776816] Starting dynamic subtest: vcs0
[381.827416] Dynamic subtest vcs0: SUCCESS (0.060s)
[381.838093] Starting dynamic subtest: vcs1
[381.893379] Dynamic subtest vcs1: SUCCESS (0.064s)
[381.904117] Starting dynamic subtest: vecs0
[381.953578] Dynamic subtest vecs0: SUCCESS (0.058s)
[381.963846] Starting dynamic subtest: ccs0
[382.017069] Dynamic subtest ccs0: SUCCESS (0.061s)
[382.019544] Subtest basic-busy: SUCCESS (0.378s)
[383.950917] [050/134] (640s left) gem_exec_schedule (thriceslice)
[384.031974] Starting subtest: thriceslice
[384.033972] Starting dynamic subtest: rcs0
[384.079989] Dynamic subtest rcs0: SUCCESS (0.058s)
[384.092081] Starting dynamic subtest: bcs0
[384.118643] Dynamic subtest bcs0: SUCCESS (0.037s)
[384.128472] Starting dynamic subtest: vcs0
[384.150437] Dynamic subtest vcs0: SUCCESS (0.031s)
[384.160245] Starting dynamic subtest: vcs1
[384.203702] Dynamic subtest vcs1: SUCCESS (0.052s)
[384.215329] Starting dynamic subtest: vecs0
[384.258141] Dynamic subtest vecs0: SUCCESS (0.053s)
[384.271265] Starting dynamic subtest: ccs0
[384.316382] Dynamic subtest ccs0: SUCCESS (0.057s)
[384.318931] Subtest thriceslice: SUCCESS (0.295s)
[384.632805] [051/134] (639s left) kms_invalid_mode (bad-vsync-end)
[384.731824] Starting subtest: bad-vsync-end
[384.734070] Starting dynamic subtest: pipe-A-eDP-1
[385.014996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[385.024779] Starting dynamic subtest: pipe-B-eDP-1
[385.027015] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[385.035267] Starting dynamic subtest: pipe-C-eDP-1
[385.037548] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[385.045812] Starting dynamic subtest: pipe-D-eDP-1
[385.048196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[385.050548] Subtest bad-vsync-end: SUCCESS (0.290s)
[385.839304] [052/134] (638s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[385.943453] Starting subtest: psr-rgb101010-draw-pwrite
[393.438627] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.498s)
[393.574369] [053/134] (630s left) vgem_slow (nohang)
[393.615381] Starting subtest: nohang
[403.882300] Subtest nohang: SUCCESS (10.266s)
[403.961786] [054/134] (620s left) kms_cursor_edge_walk (64x64-top-edge)
[404.075417] Starting subtest: 64x64-top-edge
[404.077526] Starting dynamic subtest: pipe-A-eDP-1
[407.530988] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[407.540483] Starting dynamic subtest: pipe-D-eDP-1
[410.651010] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[410.653082] Subtest 64x64-top-edge: SUCCESS (6.575s)
[411.477603] [055/134] (613s left) sysfs_timeslice_duration (invalid)
[411.544327] Starting subtest: invalid
[411.546673] Starting dynamic subtest: vecs0
[411.548993] Dynamic subtest vecs0: SUCCESS (0.000s)
[411.558723] Starting dynamic subtest: ccs0
[411.560577] Dynamic subtest ccs0: SUCCESS (0.000s)
[411.569001] Starting dynamic subtest: vcs0
[411.570930] Dynamic subtest vcs0: SUCCESS (0.000s)
[411.579412] Starting dynamic subtest: bcs0
[411.581369] Dynamic subtest bcs0: SUCCESS (0.000s)
[411.589681] Starting dynamic subtest: rcs0
[411.591547] Dynamic subtest rcs0: SUCCESS (0.000s)
[411.600803] Starting dynamic subtest: vcs1
[411.603107] Dynamic subtest vcs1: SUCCESS (0.000s)
[411.605303] Subtest invalid: SUCCESS (0.005s)
[411.667529] [056/134] (612s left) gem_tiled_wb
[411.797041] [057/134] (612s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[411.887156] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[411.889409] Starting dynamic subtest: pipe-A-eDP-1
[411.909700] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.921266] Starting dynamic subtest: pipe-B-eDP-1
[411.929597] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.938056] Starting dynamic subtest: pipe-C-eDP-1
[411.946286] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.954856] Starting dynamic subtest: pipe-D-eDP-1
[411.963278] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.968083] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[414.145458] [058/134] (610s left) kms_psr (fbc-psr2-sprite-render)
[414.244808] Starting subtest: fbc-psr2-sprite-render
[414.247014] Starting dynamic subtest: eDP-1
[414.251283] Dynamic subtest eDP-1: SKIP (0.000s)
[414.255652] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[414.344894] [059/134] (610s left) gem_mmap_wc (bad-offset)
[414.421013] Subtest bad-offset: SKIP (0.000s)
[414.483460] [060/134] (610s left) kms_cursor_crc (cursor-onscreen-32x10)
[414.648634] Starting subtest: cursor-onscreen-32x10
[414.696023] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[414.989343] [061/134] (609s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[415.094817] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[415.098191] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[415.245633] [062/134] (609s left) gem_exec_whisper (basic-normal)
[415.305705] Starting subtest: basic-normal
[419.049336] Subtest basic-normal: SUCCESS (3.741s)
[419.255102] [063/134] (605s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[419.318141] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[419.425708] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[419.512987] [064/134] (605s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[420.075608] Starting subtest: syncobj-timeline-invalid-flags
[420.077867] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[421.002519] [065/134] (603s left) sw_sync (sync_merge_invalid)
[421.047440] Starting subtest: sync_merge_invalid
[421.070350] Subtest sync_merge_invalid: SUCCESS (0.022s)
[421.166565] [066/134] (603s left) kms_chamelium_hpd (dp-hpd-fast)
[421.557302] Subtest dp-hpd-fast: SKIP (0.000s)
[422.344796] [067/134] (602s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[422.443188] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[422.447657] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[422.555364] [068/134] (602s left) gem_ctx_persistence (legacy-engines-hostile)
[422.604552] Starting subtest: legacy-engines-hostile
[422.606744] Starting dynamic subtest: render
[422.731404] Dynamic subtest render: SUCCESS (0.126s)
[422.745958] Starting dynamic subtest: bsd1
[422.850592] Dynamic subtest bsd1: SUCCESS (0.116s)
[422.865028] Starting dynamic subtest: bsd2
[422.971721] Dynamic subtest bsd2: SUCCESS (0.117s)
[422.984032] Starting dynamic subtest: blt
[423.086216] Dynamic subtest blt: SUCCESS (0.112s)
[423.100292] Starting dynamic subtest: vebox
[423.194258] Dynamic subtest vebox: SUCCESS (0.105s)
[423.196755] Subtest legacy-engines-hostile: SUCCESS (0.591s)
[423.284776] [069/134] (601s left) gem_exec_balancer (fairslice)
[423.344830] Starting subtest: fairslice
[426.241585] Subtest fairslice: SUCCESS (2.895s)
[427.021837] [070/134] (598s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[427.125994] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[427.130381] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[427.225792] [071/134] (597s left) prime_vgem (sync)
[427.342865] Starting subtest: sync
[427.345202] Starting dynamic subtest: rcs0
[427.396306] Dynamic subtest rcs0: SUCCESS (0.054s)
[427.405309] Starting dynamic subtest: bcs0
[427.473310] Dynamic subtest bcs0: SUCCESS (0.075s)
[427.482151] Starting dynamic subtest: vcs0
[427.521246] Dynamic subtest vcs0: SUCCESS (0.048s)
[427.530390] Starting dynamic subtest: vcs1
[427.567376] Dynamic subtest vcs1: SUCCESS (0.045s)
[427.576857] Starting dynamic subtest: vecs0
[427.612783] Dynamic subtest vecs0: SUCCESS (0.044s)
[427.621515] Starting dynamic subtest: ccs0
[427.659238] Dynamic subtest ccs0: SUCCESS (0.046s)
[427.661546] Subtest sync: SUCCESS (0.317s)
[427.821130] [072/134] (597s left) gem_exec_flush (basic-wb-ro-default)
[427.886790] Starting subtest: basic-wb-ro-default
[433.334200] Subtest basic-wb-ro-default: SUCCESS (5.448s)
[433.535755] [073/134] (591s left) kms_psr (psr-cursor-blt)
[433.633555] Starting subtest: psr-cursor-blt
[433.635801] Starting dynamic subtest: eDP-1
[435.356727] Dynamic subtest eDP-1: SUCCESS (1.723s)
[435.359017] Subtest psr-cursor-blt: SUCCESS (1.724s)
[436.234097] [074/134] (589s left) kms_psr (fbc-psr2-sprite-plane-move)
[436.336466] Starting subtest: fbc-psr2-sprite-plane-move
[436.338727] Starting dynamic subtest: eDP-1
[436.342932] Dynamic subtest eDP-1: SKIP (0.000s)
[436.347145] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[436.420195] [075/134] (588s left) kms_frontbuffer_tracking (psr-slowdraw)
[436.537718] Starting subtest: psr-slowdraw
[461.666153] Subtest psr-slowdraw: SUCCESS (25.130s)
[461.802497] [076/134] (563s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[461.897929] Starting subtest: fbcpsr-tiling-4
[468.962779] Subtest fbcpsr-tiling-4: SUCCESS (7.067s)
[469.104509] [077/134] (556s left) kms_dp_link_training (uhbr-sst)
[469.193505] Starting subtest: uhbr-sst
[469.201927] Subtest uhbr-sst: SKIP (0.000s)
[469.277687] [078/134] (556s left) gem_mmap_gtt (medium-copy-xy)
[469.329093] Subtest medium-copy-XY: SKIP (0.000s)
[469.394575] [079/134] (556s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[469.481599] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[469.483875] Starting dynamic subtest: pipe-A-default-mode
[472.188063] Dynamic subtest pipe-A-default-mode: SUCCESS (2.706s)
[472.190238] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.708s)
[473.066841] [080/134] (552s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[473.118927] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[473.185735] [081/134] (552s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[473.290164] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[474.368593] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[474.526092] [082/134] (551s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[474.623993] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[474.625805] Starting dynamic subtest: pipe-A-eDP-1
[475.038955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[475.050171] Starting dynamic subtest: pipe-B-eDP-1
[475.067096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[475.075907] Starting dynamic subtest: pipe-C-eDP-1
[475.091995] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[475.100082] Starting dynamic subtest: pipe-D-eDP-1
[475.115884] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[475.117683] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.431s)
[477.336331] [083/134] (548s left) kms_pm_rpm (cursor-dpms)
[479.059903] Starting subtest: cursor-dpms
[479.064614] Subtest cursor-dpms: SKIP (0.000s)
[479.644786] [084/134] (546s left) gem_mmap_gtt (basic-write-read-distinct)
[479.705138] Subtest basic-write-read-distinct: SKIP (0.000s)
[479.763333] [085/134] (546s left) gen9_exec_parse (bb-start-out)
[479.825567] Subtest bb-start-out: SKIP (0.000s)
[479.928915] [086/134] (545s left) kms_content_protection (dp-mst-type-1)
[480.071609] Starting subtest: dp-mst-type-1
[480.076348] Subtest dp-mst-type-1: SKIP (0.000s)
[480.230210] [087/134] (545s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[480.333603] Starting subtest: drrs-dirtyfb-ioctl
[480.346823] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[480.456580] [088/134] (545s left) gem_lmem_swapping (massive)
[480.507002] Subtest massive: SKIP (0.000s)
[480.553918] [089/134] (545s left) kms_vblank (query-forked-busy)
[480.641965] Starting subtest: query-forked-busy
[480.643572] Starting dynamic subtest: pipe-A-eDP-1
[482.521431] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[482.535753] Starting dynamic subtest: pipe-D-eDP-1
[485.101880] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[485.103867] Subtest query-forked-busy: SUCCESS (4.459s)
[485.915300] [090/134] (540s left) gem_ctx_isolation (preservation-s3)
[485.980628] Starting subtest: preservation-S3
[485.982998] Starting dynamic subtest: rcs0
[502.558136] Dynamic subtest rcs0: SUCCESS (1.296s)
[502.567979] Starting dynamic subtest: bcs0
[518.560051] Dynamic subtest bcs0: SUCCESS (1.338s)
[518.570941] Starting dynamic subtest: vcs0
[534.557115] Dynamic subtest vcs0: SUCCESS (2.367s)
[534.568110] Starting dynamic subtest: vcs1
[552.546819] Dynamic subtest vcs1: SUCCESS (4.988s)
[552.556484] Starting dynamic subtest: vecs0
[570.567306] Dynamic subtest vecs0: SUCCESS (4.994s)
[570.577359] Starting dynamic subtest: ccs0
[588.567300] Dynamic subtest ccs0: SUCCESS (3.153s)
[588.570641] Subtest preservation-S3: SUCCESS (18.142s)
[588.828144] [091/134] (437s left) kms_lease (lease-unleased-crtc)
[588.932953] Starting subtest: lease-unleased-crtc
[588.935483] Starting dynamic subtest: pipe-A-eDP-1
[589.221667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[589.233343] Starting dynamic subtest: pipe-B-eDP-1
[589.940820] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.716s)
[589.955387] Starting dynamic subtest: pipe-C-eDP-1
[589.957901] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[589.966910] Starting dynamic subtest: pipe-D-eDP-1
[589.969005] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[589.971198] Subtest lease-unleased-crtc: SUCCESS (1.021s)
[590.338725] [092/134] (435s left) i915_selftest (live)
[592.256921] Starting subtest: live
[592.259057] Starting dynamic subtest: sanitycheck
[596.304612] Dynamic subtest sanitycheck: SUCCESS (4.044s)
[596.320276] Starting dynamic subtest: uncore
[602.069268] Dynamic subtest uncore: SUCCESS (5.757s)
[602.078995] Starting dynamic subtest: workarounds
[621.631427] Dynamic subtest workarounds: FAIL (19.006s)
[621.640933] Starting dynamic subtest: gt_engines
[625.605573] Dynamic subtest gt_engines: SUCCESS (4.515s)
[625.615299] Starting dynamic subtest: gt_timelines
[642.353612] Dynamic subtest gt_timelines: SUCCESS (16.738s)
[642.369671] Starting dynamic subtest: gt_contexts
[646.491811] Dynamic subtest gt_contexts: SUCCESS (4.133s)
[646.501982] Starting dynamic subtest: gt_lrc
[652.244679] Dynamic subtest gt_lrc: SUCCESS (5.748s)
[652.254823] Starting dynamic subtest: gt_mocs
[656.721292] Dynamic subtest gt_mocs: SUCCESS (4.472s)
[656.731632] Starting dynamic subtest: gt_pm
[662.894700] Dynamic subtest gt_pm: SUCCESS (6.168s)
[662.904957] Starting dynamic subtest: gt_heartbeat
[668.610852] Dynamic subtest gt_heartbeat: SUCCESS (5.711s)
[668.619601] Starting dynamic subtest: gt_tlb
[679.494145] Dynamic subtest gt_tlb: SUCCESS (10.876s)
[679.504138] Starting dynamic subtest: requests
[692.546507] Dynamic subtest requests: SUCCESS (13.055s)
[692.556274] Starting dynamic subtest: migrate
[700.024983] Dynamic subtest migrate: SUCCESS (7.480s)
[700.035358] Starting dynamic subtest: active
[704.057805] Dynamic subtest active: SUCCESS (4.033s)
[704.073869] Starting dynamic subtest: objects
[708.764026] Dynamic subtest objects: SUCCESS (4.705s)
[708.773669] Starting dynamic subtest: mman
[713.424012] Dynamic subtest mman: SUCCESS (4.659s)
[713.433882] Starting dynamic subtest: dmabuf
[719.146929] Dynamic subtest dmabuf: SUCCESS (5.722s)
[719.157268] Starting dynamic subtest: vma
[723.248088] Dynamic subtest vma: SUCCESS (4.100s)
[723.258174] Starting dynamic subtest: coherency
[728.598202] Dynamic subtest coherency: SUCCESS (5.348s)
[728.606868] Starting dynamic subtest: gtt
[741.885856] Dynamic subtest gtt: SUCCESS (13.284s)
[741.896116] Starting dynamic subtest: gem
[751.629998] Dynamic subtest gem: SUCCESS (9.741s)
[751.641055] Starting dynamic subtest: evict
[757.059808] Dynamic subtest evict: SUCCESS (5.426s)
[757.075387] Starting dynamic subtest: hugepages
[767.359741] Dynamic subtest hugepages: SUCCESS (10.296s)
[767.370013] Starting dynamic subtest: gem_contexts
[797.234257] Dynamic subtest gem_contexts: SUCCESS (29.865s)
[797.244235] Starting dynamic subtest: client
[801.406250] Dynamic subtest client: SUCCESS (4.170s)
[801.415858] Starting dynamic subtest: gem_migrate
[805.480361] Dynamic subtest gem_migrate: SUCCESS (4.071s)
[805.496594] Starting dynamic subtest: reset
[810.045256] Dynamic subtest reset: SUCCESS (4.561s)
[810.055002] Starting dynamic subtest: memory_region
[814.200999] Dynamic subtest memory_region: SUCCESS (4.154s)
[814.211487] Starting dynamic subtest: hangcheck
[828.601064] Dynamic subtest hangcheck: SUCCESS (14.402s)
[828.611280] Starting dynamic subtest: execlists
[832.812928] Dynamic subtest execlists: SUCCESS (4.211s)
[832.822987] Starting dynamic subtest: ring_submission
[836.940381] Dynamic subtest ring_submission: SUCCESS (4.126s)
[836.950297] Starting dynamic subtest: perf
[841.281556] Dynamic subtest perf: SUCCESS (4.340s)
[841.292351] Starting dynamic subtest: slpc
[856.903136] Dynamic subtest slpc: SUCCESS (15.620s)
[856.913804] Starting dynamic subtest: guc
[862.193039] Dynamic subtest guc: SUCCESS (5.288s)
[862.203735] Starting dynamic subtest: guc_multi_lrc
[868.005873] Dynamic subtest guc_multi_lrc: SUCCESS (5.810s)
[868.021639] Starting dynamic subtest: guc_hang
[872.874794] Dynamic subtest guc_hang: SUCCESS (4.866s)
[872.890329] Starting dynamic subtest: late_gt_pm
[876.965287] Dynamic subtest late_gt_pm: SUCCESS (4.088s)
[876.968100] Subtest live: FAIL (284.661s)
[877.000975] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[877.001719] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[877.005581] [093/134] (149s left) gem_render_copy (y-tiled)
[879.872945] Starting subtest: y-tiled
[879.877993] Subtest y-tiled: SKIP (0.000s)
[880.021551] [FACT gem_render_copy (y-tiled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[880.022898] [FACT gem_render_copy (y-tiled)] new: kernel.kmod_is_loaded.i915: true
[880.027207] [094/134] (146s left) kms_psr (pr-primary-page-flip)
[880.114056] Starting subtest: pr-primary-page-flip
[880.119177] Subtest pr-primary-page-flip: SKIP (0.000s)
[880.198665] [095/134] (146s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[880.303784] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[880.339815] Starting dynamic subtest: pipe-A-plane-0
[880.345151] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[880.354162] Starting dynamic subtest: pipe-A-plane-3
[880.358791] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[880.367358] Starting dynamic subtest: pipe-A-plane-5
[880.372095] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[881.428231] Starting dynamic subtest: pipe-B-plane-0
[881.433127] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[881.441164] Starting dynamic subtest: pipe-B-plane-3
[881.446337] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[881.455067] Starting dynamic subtest: pipe-B-plane-5
[881.460690] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[881.760029] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (1.453s)
[882.617570] [096/134] (143s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[882.717336] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[882.722256] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[882.848057] [097/134] (143s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[882.920074] Starting subtest: mixed-tiled-to-y-tiled-ccs
[882.925107] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[883.115420] [098/134] (143s left) kms_cdclk (plane-scaling)
[883.221641] Starting subtest: plane-scaling
[883.223917] Starting dynamic subtest: pipe-A-eDP-1
[883.511138] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[883.520627] Starting dynamic subtest: pipe-B-eDP-1
[883.525816] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[883.535994] Starting dynamic subtest: pipe-C-eDP-1
[883.541178] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[883.549197] Starting dynamic subtest: pipe-D-eDP-1
[883.554251] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[883.559104] Subtest plane-scaling: SKIP (0.293s)
[884.351546] [099/134] (142s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[884.462378] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[884.467171] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[884.566953] [100/134] (141s left) gem_spin_batch (spin-all)
[884.626889] Starting subtest: spin-all
[884.645402] Subtest spin-all: SUCCESS (0.016s)
[886.411041] [101/134] (140s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[886.508387] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[886.513819] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[886.627928] [102/134] (139s left) api_intel_bb (simple-bb-ctx)
[886.679786] Starting subtest: simple-bb-ctx
[886.691247] Subtest simple-bb-ctx: SUCCESS (0.012s)
[886.844648] [103/134] (139s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[886.947276] Starting subtest: 4-tiled-64bpp-rotate-270
[886.967137] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[887.120076] [104/134] (139s left) api_intel_bb (blit-reloc-keep-cache)
[887.179830] Starting subtest: blit-reloc-keep-cache
[887.184380] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[887.322517] [105/134] (139s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[887.415916] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[887.420067] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[887.528285] [106/134] (139s left) i915_drm_fdinfo (memory-info-purgeable)
[887.564256] Starting subtest: memory-info-purgeable
[887.566896] Starting dynamic subtest: smem0
[890.028572] Dynamic subtest smem0: SUCCESS (2.465s)
[890.030981] Subtest memory-info-purgeable: SUCCESS (2.465s)
[890.113403] [107/134] (136s left) syncobj_timeline (signal-array)
[890.176116] Starting subtest: signal-array
[890.178767] Subtest signal-array: SUCCESS (0.000s)
[890.298393] [108/134] (136s left) i915_pm_rpm (gem-pread)
[892.532317] Starting subtest: gem-pread
[894.560061] Subtest gem-pread: SUCCESS (2.031s)
[894.692719] [109/134] (132s left) sw_sync (alloc_fence_invalid_timeline)
[894.737120] Starting subtest: alloc_fence_invalid_timeline
[894.739210] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[894.801901] [110/134] (132s left) gem_exec_schedule (manyslice)
[894.883033] Starting subtest: manyslice
[894.885272] Starting dynamic subtest: rcs0
[900.008355] Dynamic subtest rcs0: SUCCESS (5.135s)
[900.021745] Starting dynamic subtest: bcs0
[907.672982] Dynamic subtest bcs0: SUCCESS (7.662s)
[907.686739] Starting dynamic subtest: vcs0
[913.789262] Dynamic subtest vcs0: SUCCESS (6.115s)
[913.803864] Starting dynamic subtest: vcs1
[920.398403] Dynamic subtest vcs1: SUCCESS (6.605s)
[920.411337] Starting dynamic subtest: vecs0
[926.994281] Dynamic subtest vecs0: SUCCESS (6.593s)
[927.006261] Starting dynamic subtest: ccs0
[933.673173] Dynamic subtest ccs0: SUCCESS (6.676s)
[933.676173] Subtest manyslice: SUCCESS (38.796s)
[933.983287] [111/134] ( 92s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[934.268360] Starting subtest: cursor-rapid-movement-256x256
[934.271368] Starting dynamic subtest: pipe-A-eDP-1
[934.802063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[934.834505] Starting dynamic subtest: pipe-D-eDP-1
[936.025342] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s)
[936.028214] Subtest cursor-rapid-movement-256x256: SUCCESS (1.758s)
[936.892405] [112/134] ( 90s left) kms_flip (absolute-wf_vblank-interruptible)
[936.986796] Starting subtest: absolute-wf_vblank-interruptible
[936.989267] Starting dynamic subtest: A-eDP1
[945.748781] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[945.758414] Starting dynamic subtest: B-eDP1
[954.484087] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[954.493752] Starting dynamic subtest: C-eDP1
[963.201692] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[963.213397] Starting dynamic subtest: D-eDP1
[971.936827] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[971.939473] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.945s)
[973.160408] [113/134] ( 53s left) kms_setmode (basic)
[973.227931] Starting subtest: basic
[973.551342] Starting dynamic subtest: pipe-A-eDP-1
[975.660374] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s)
[976.000962] Starting dynamic subtest: pipe-B-eDP-1
[978.090640] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.093s)
[978.399967] Subtest basic: SUCCESS (5.168s)
[979.263588] [114/134] ( 47s left) gem_mmap_offset (open-flood)
[979.318479] Starting subtest: open-flood
[1000.809914] Subtest open-flood: SUCCESS (21.489s)
[1000.952642] [115/134] ( 26s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[1006.016278] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[1006.019234] Starting dynamic subtest: pipe-A-eDP-1
[1006.823162] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[1006.833387] Starting dynamic subtest: pipe-B-eDP-1
[1007.962215] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[1007.967171] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.947s)
[1009.151557] [116/134] ( 17s left) kms_addfb_basic (addfb25-bad-modifier)
[1009.249358] Starting subtest: addfb25-bad-modifier
[1009.252154] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[1009.385181] [117/134] ( 17s left) gem_exec_create (forked)
[1009.437621] Starting subtest: forked
[1009.440111] Starting dynamic subtest: smem
[1031.316054] Dynamic subtest smem: SUCCESS (21.871s)
[1031.319213] Subtest forked: SUCCESS (21.873s)
[1031.501090] Overall timeout time exceeded, stopping.
[1031.519676] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: dmabuf_sync_file
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_media_vme
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: gem_ctx_engines
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_wait
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: gem_fence_thrash
results: parsing output: 30/ for test: kms_busy
results: parsing output: 31/ for test: kms_atomic
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_exec_parallel
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_color
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pipe_crc_basic
results: parsing output: 47/ for test: gem_tiled_blits
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: vgem_slow
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: sysfs_timeslice_duration
results: parsing output: 55/ for test: gem_tiled_wb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_mmap_wc
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_dp_link_training
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: kms_content_protection
results: parsing output: 86/ for test: kms_dirtyfb
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: gem_ctx_isolation
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_selftest
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_cdclk
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_spin_batch
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: i915_pm_rpm
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_setmode
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_exec_create
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 118/ for test: gem_ctx_shared
results: no output, setting notrun
results: parsing output: 119/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 120/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 121/ for test: gen3_render_tiledx_blits
results: no output, setting notrun
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 123/ for test: kms_plane_lowres
results: no output, setting notrun
results: parsing output: 124/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 125/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 126/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 128/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 129/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 131/ for test: gem_mmap
results: no output, setting notrun
results: parsing output: 132/ for test: syncobj_basic
results: no output, setting notrun
results: parsing output: 133/ for test: gem_fenced_exec_thrash
results: no output, setting notrun
Done.