[149.226084] Initializing watchdogs
[149.226182]   /dev/watchdog0
[149.241412] [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]
[149.248347] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[149.250640] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[149.253949] [001/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[149.369984] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[149.372473] Starting dynamic subtest: pipe-A-eDP-1
[149.546487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.168s)
[149.555938] Starting dynamic subtest: pipe-B-eDP-1
[149.576445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[149.583741] Starting dynamic subtest: pipe-C-eDP-1
[149.603398] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[149.610025] Starting dynamic subtest: pipe-D-eDP-1
[149.630158] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[149.632341] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.176s)
[152.094386] [002/133] (957s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[152.192119] Starting subtest: basic-modeset-with-all-modifiers-formats
[152.564239] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[153.378953] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.815s)
[153.386032] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[153.400763] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[153.407499] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[153.422133] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[153.432929] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[153.578076] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.154s)
[153.585493] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[153.599982] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[153.607137] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[153.622266] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[153.629153] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[153.644452] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[153.651241] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[153.666690] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[153.673626] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[153.688624] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[153.695599] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[153.711201] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[153.718248] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[153.733468] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[153.742849] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[153.755512] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[153.762743] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[153.912847] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[153.923412] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[153.934725] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[153.942593] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[153.957574] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[153.964495] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[153.979826] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[153.989197] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[154.000130] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[154.006938] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[154.022363] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[154.031517] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[154.044801] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[154.051639] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[154.066455] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[154.073496] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[154.089112] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[154.098734] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[154.245058] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[154.253509] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[154.267277] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[154.274220] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[154.289452] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[154.296475] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[154.311776] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[154.319016] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[154.333935] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[154.341743] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[154.355907] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[154.362889] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[154.378098] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[154.385166] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[154.400070] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[154.407047] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[154.422480] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[154.805287] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.615s)
[155.659210] [003/133] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[155.770217] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[155.774337] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[155.845522] [004/133] (954s left) kms_addfb_basic (unused-modifier)
[155.895673] Starting subtest: unused-modifier
[155.897937] Subtest unused-modifier: SUCCESS (0.000s)
[156.027678] [005/133] (953s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[156.117807] Starting subtest: psr-rgb565-draw-mmap-gtt
[156.122176] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[156.212281] [006/133] (953s left) kms_psr (fbc-psr-primary-blt)
[156.304271] Starting subtest: fbc-psr-primary-blt
[156.306433] Starting dynamic subtest: eDP-1
[156.310696] Dynamic subtest eDP-1: SKIP (0.000s)
[156.315040] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[156.370651] [007/133] (953s left) gem_exec_balancer (parallel-bb-first)
[156.646019] Starting subtest: parallel-bb-first
[157.588287] Subtest parallel-bb-first: SUCCESS (0.942s)
[157.958402] [008/133] (952s left) kms_cursor_edge_walk (64x64-top-bottom)
[158.047802] Starting subtest: 64x64-top-bottom
[158.049985] Starting dynamic subtest: pipe-A-eDP-1
[161.518854] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[161.526683] Starting dynamic subtest: pipe-D-eDP-1
[164.648606] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[164.650778] Subtest 64x64-top-bottom: SUCCESS (6.601s)
[165.446966] [009/133] (944s left) kms_flip (modeset-vs-vblank-race)
[165.546077] Starting subtest: modeset-vs-vblank-race
[165.548205] Starting dynamic subtest: A-eDP1
[170.272026] Dynamic subtest A-eDP1: SUCCESS (4.727s)
[170.283113] Starting dynamic subtest: B-eDP1
[175.011815] Dynamic subtest B-eDP1: SUCCESS (4.738s)
[175.021643] Starting dynamic subtest: C-eDP1
[179.639714] Dynamic subtest C-eDP1: SUCCESS (4.626s)
[179.647133] Starting dynamic subtest: D-eDP1
[184.107287] Dynamic subtest D-eDP1: SUCCESS (4.467s)
[184.109772] Subtest modeset-vs-vblank-race: SUCCESS (18.566s)
[185.269167] [010/133] (924s left) kms_psr (fbc-pr-cursor-blt)
[185.362143] Starting subtest: fbc-pr-cursor-blt
[185.366204] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[185.431239] [011/133] (924s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[185.526122] Starting subtest: fbc-1p-pri-indfb-multidraw
[198.546957] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.024s)
[199.895441] [012/133] (910s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[199.948760] Starting subtest: single-wait-all-for-submit-unsubmitted
[200.057934] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[200.129786] [013/133] (910s left) kms_psr (psr2-primary-page-flip)
[200.216680] Starting subtest: psr2-primary-page-flip
[200.218897] Starting dynamic subtest: eDP-1
[201.990623] Dynamic subtest eDP-1: SUCCESS (1.772s)
[201.992786] Subtest psr2-primary-page-flip: SUCCESS (1.773s)
[202.858413] [014/133] (907s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[202.960523] Starting subtest: psr-2p-primscrn-cur-indfb-move
[202.964596] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[203.061822] [015/133] (907s left) gem_exec_fence (syncobj-timeline-repeat)
[203.634907] Starting subtest: syncobj-timeline-repeat
[203.895939] Subtest syncobj-timeline-repeat: SUCCESS (0.261s)
[204.957359] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[204.960507] [016/133] (905s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[205.065776] Starting subtest: yf-tiled-8bpp-rotate-90
[205.069894] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[205.148205] [017/133] (905s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[205.522605] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[206.373149] [018/133] (904s left) gem_mmap_gtt (hang-busy)
[206.431677] Subtest hang-busy: SKIP (0.000s)
[206.488842] [019/133] (903s left) perf_pmu (multi-client)
[206.533924] Starting subtest: multi-client
[206.536224] Starting dynamic subtest: rcs0
[207.596754] Dynamic subtest rcs0: SUCCESS (1.061s)
[207.607323] Starting dynamic subtest: bcs0
[208.646885] Dynamic subtest bcs0: SUCCESS (1.048s)
[208.657367] Starting dynamic subtest: vcs0
[209.697521] Dynamic subtest vcs0: SUCCESS (1.049s)
[209.708112] Starting dynamic subtest: vcs1
[210.894321] Dynamic subtest vcs1: SUCCESS (1.195s)
[210.904637] Starting dynamic subtest: vecs0
[212.940048] Dynamic subtest vecs0: SUCCESS (2.044s)
[212.950596] Starting dynamic subtest: ccs0
[214.926902] Dynamic subtest ccs0: SUCCESS (1.985s)
[214.929934] Subtest multi-client: SUCCESS (8.392s)
[215.044875] [020/133] (895s left) kms_lease (atomic-implicit-crtc)
[215.141608] Starting subtest: atomic-implicit-crtc
[215.143817] Starting dynamic subtest: pipe-A-eDP-1
[215.155614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[215.166675] Starting dynamic subtest: pipe-B-eDP-1
[215.177517] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[215.185078] Starting dynamic subtest: pipe-C-eDP-1
[215.195280] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[215.202756] Starting dynamic subtest: pipe-D-eDP-1
[215.213318] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[215.215284] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[215.325625] [021/133] (895s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[215.431301] Starting subtest: extended-modeset-hang-oldfb-with-reset
[215.433555] Starting dynamic subtest: pipe-A
[227.268886] Dynamic subtest pipe-A: SUCCESS (11.835s)
[227.278821] Starting dynamic subtest: pipe-D
[239.541023] Dynamic subtest pipe-D: SUCCESS (12.271s)
[239.543211] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.110s)
[240.418588] [022/133] (870s left) gem_exec_fence (syncobj-unused-fence)
[240.831098] Starting subtest: syncobj-unused-fence
[240.836044] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[241.971310] [023/133] (868s left) kms_flip (flip-vs-suspend)
[242.064887] Starting subtest: flip-vs-suspend
[242.067638] Starting dynamic subtest: A-eDP1
[275.219705] Dynamic subtest A-eDP1: SUCCESS (5.072s)
[275.229274] Starting dynamic subtest: B-eDP1
[309.220084] Dynamic subtest B-eDP1: SUCCESS (4.244s)
[309.234464] Starting dynamic subtest: C-eDP1
[343.245992] Dynamic subtest C-eDP1: SUCCESS (4.243s)
[343.255813] Starting dynamic subtest: D-eDP1
[377.224896] Dynamic subtest D-eDP1: SUCCESS (4.149s)
[377.229893] Subtest flip-vs-suspend: SUCCESS (17.715s)
[388.476700] [024/133] (732s left) prime_self_import (export-vs-gem_close-race)
[388.531765] Starting subtest: export-vs-gem_close-race
[393.626472] Subtest export-vs-gem_close-race: SUCCESS (5.085s)
[393.706627] [025/133] (727s left) syncobj_timeline (invalid-transfer-bad-pad)
[393.762293] Starting subtest: invalid-transfer-bad-pad
[393.765111] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[393.901064] [026/133] (726s left) kms_invalid_mode (bad-vsync-end)
[393.999395] Starting subtest: bad-vsync-end
[394.002234] Starting dynamic subtest: pipe-A-eDP-1
[394.292410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[394.301599] Starting dynamic subtest: pipe-B-eDP-1
[394.304319] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[394.313496] Starting dynamic subtest: pipe-C-eDP-1
[394.316272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[394.324925] Starting dynamic subtest: pipe-D-eDP-1
[394.327661] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[394.330488] Subtest bad-vsync-end: SUCCESS (0.302s)
[395.148324] [027/133] (725s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[395.263371] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[395.268345] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[395.332831] [028/133] (725s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[395.418018] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[395.422575] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[395.515441] [029/133] (725s left) i915_query (engine-info)
[395.563903] Starting subtest: engine-info
[395.569231] Subtest engine-info: SUCCESS (0.005s)
[395.679572] [030/133] (725s left) kms_draw_crc (draw-method-mmap-cpu)
[395.761938] Starting subtest: draw-method-mmap-cpu
[395.764185] Starting dynamic subtest: xrgb8888-untiled
[396.026998] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[396.045470] Starting dynamic subtest: rgb565-untiled
[396.227802] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[396.236624] Starting dynamic subtest: xrgb2101010-untiled
[396.449700] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[396.458610] Starting dynamic subtest: xbgr16161616f-untiled
[396.672118] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[396.681515] Starting dynamic subtest: xrgb8888-xtiled
[396.805400] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[396.814409] Starting dynamic subtest: rgb565-xtiled
[396.940385] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[396.949104] Starting dynamic subtest: xrgb2101010-xtiled
[397.060679] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[397.069507] Starting dynamic subtest: xbgr16161616f-xtiled
[397.194192] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[397.203116] Starting dynamic subtest: xrgb8888-4tiled
[397.339685] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[397.347841] Starting dynamic subtest: rgb565-4tiled
[397.483493] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[397.491948] Starting dynamic subtest: xrgb2101010-4tiled
[397.617176] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s)
[397.627064] Starting dynamic subtest: xbgr16161616f-4tiled
[397.761040] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[397.763370] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[397.866050] [031/133] (723s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[397.957749] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[397.962203] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[399.084878] [032/133] (721s left) gem_caching (writes)
[399.144460] Subtest writes: SKIP (0.000s)
[399.210946] [033/133] (721s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[399.301751] Starting subtest: coverage-vs-premult-vs-constant
[399.609513] Starting dynamic subtest: pipe-A-eDP-1
[400.190302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[400.199836] Starting dynamic subtest: pipe-D-eDP-1
[401.485214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[401.487821] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.187s)
[402.338541] [034/133] (718s left) syncobj_timeline (reset-signaled)
[402.405264] Starting subtest: reset-signaled
[402.408381] Subtest reset-signaled: SUCCESS (0.000s)
[402.519236] [035/133] (718s left) syncobj_wait (multi-wait-for-submit-signaled)
[402.572506] Starting subtest: multi-wait-for-submit-signaled
[402.575195] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[402.674669] [036/133] (718s left) gem_spin_batch (resubmit-all)
[402.732071] Starting subtest: resubmit-all
[402.734383] Starting dynamic subtest: rcs0
[402.742917] Dynamic subtest rcs0: SUCCESS (0.013s)
[402.754284] Starting dynamic subtest: bcs0
[402.757725] Dynamic subtest bcs0: SUCCESS (0.003s)
[402.767154] Starting dynamic subtest: vcs0
[402.769926] Dynamic subtest vcs0: SUCCESS (0.002s)
[402.780473] Starting dynamic subtest: vcs1
[402.782753] Dynamic subtest vcs1: SUCCESS (0.002s)
[402.791125] Starting dynamic subtest: vecs0
[402.793260] Dynamic subtest vecs0: SUCCESS (0.002s)
[402.802159] Starting dynamic subtest: ccs0
[402.804325] Dynamic subtest ccs0: SUCCESS (0.002s)
[402.806581] Subtest resubmit-all: SUCCESS (0.030s)
[404.423824] [037/133] (716s left) gem_eio (in-flight-contexts-immediate)
[404.620234] Starting subtest: in-flight-contexts-immediate
[418.356079] Subtest in-flight-contexts-immediate: SUCCESS (13.733s)
[418.473210] [038/133] (702s left) gem_exec_fence (basic-wait)
[418.648945] Starting subtest: basic-wait
[418.651402] Starting dynamic subtest: rcs0
[418.705397] Dynamic subtest rcs0: SUCCESS (0.057s)
[418.717637] Starting dynamic subtest: bcs0
[418.763070] Dynamic subtest bcs0: SUCCESS (0.055s)
[418.774652] Starting dynamic subtest: vcs0
[418.816363] Dynamic subtest vcs0: SUCCESS (0.051s)
[418.826471] Starting dynamic subtest: vcs1
[418.869735] Dynamic subtest vcs1: SUCCESS (0.051s)
[418.881889] Starting dynamic subtest: vecs0
[418.924934] Dynamic subtest vecs0: SUCCESS (0.053s)
[418.936630] Starting dynamic subtest: ccs0
[418.982967] Dynamic subtest ccs0: SUCCESS (0.056s)
[418.986062] Subtest basic-wait: SUCCESS (0.335s)
[420.395955] [039/133] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[420.503416] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[420.508003] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[420.604295] [040/133] (700s left) kms_chamelium_audio (dp-audio)
[420.989404] Subtest dp-audio: SKIP (0.000s)
[421.757806] [041/133] (699s left) kms_async_flips (crc-atomic)
[421.852308] Starting subtest: crc-atomic
[422.222951] Starting dynamic subtest: pipe-A-eDP-1
[425.100388] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.877s)
[425.492301] Starting dynamic subtest: pipe-B-eDP-1
[428.450417] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.951s)
[428.824925] Starting dynamic subtest: pipe-C-eDP-1
[431.789856] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.942s)
[432.120884] Starting dynamic subtest: pipe-D-eDP-1
[434.989480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.844s)
[434.992278] Subtest crc-atomic: SUCCESS (13.105s)
[436.134794] [042/133] (685s left) kms_psr (fbc-psr2-no-drrs)
[436.221296] Starting subtest: fbc-psr2-no-drrs
[436.224171] Starting dynamic subtest: eDP-1
[436.229279] Dynamic subtest eDP-1: SKIP (0.000s)
[436.234239] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[436.294836] [043/133] (685s left) kms_cursor_crc (cursor-onscreen-64x21)
[436.500829] Starting subtest: cursor-onscreen-64x21
[436.549228] Subtest cursor-onscreen-64x21: SKIP (0.044s)
[436.785144] [044/133] (684s left) gem_pxp (hw-rejects-pxp-buffer)
[436.922077] Starting subtest: hw-rejects-pxp-buffer
[436.928263] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[437.027675] [045/133] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[437.129305] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[437.133714] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[437.215890] [046/133] (684s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[437.305907] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[437.331831] Starting dynamic subtest: pipe-A-plane-0
[437.620792] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[437.629760] Starting dynamic subtest: pipe-A-plane-3
[437.865206] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[437.874634] Starting dynamic subtest: pipe-A-plane-5
[437.879143] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[438.924251] Starting dynamic subtest: pipe-B-plane-0
[439.239454] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[439.256125] Starting dynamic subtest: pipe-B-plane-3
[439.472467] Dynamic subtest pipe-B-plane-3: SUCCESS (0.230s)
[439.483985] Starting dynamic subtest: pipe-B-plane-5
[439.489156] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[439.785746] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.481s)
[440.594599] [047/133] (681s left) api_intel_bb (misplaced-blitter)
[440.647358] Starting subtest: misplaced-blitter
[440.652691] Subtest misplaced-blitter: SUCCESS (0.007s)
[440.762377] [048/133] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[440.858271] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[440.863216] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[440.947285] [049/133] (680s left) gem_create (create-ext-placement-all)
[441.121736] Starting subtest: create-ext-placement-all
[441.124747] Subtest create-ext-placement-all: SUCCESS (0.000s)
[441.224246] [050/133] (680s left) i915_pm_rpm (gem-idle)
[443.472929] Starting subtest: gem-idle
[449.679930] Subtest gem-idle: SUCCESS (6.196s)
[450.007534] [051/133] (671s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[451.266796] Starting subtest: multi-wait-all-for-submit-submitted
[451.371638] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[451.456696] [052/133] (670s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[451.548407] Starting subtest: blocking-absolute-wf_vblank-interruptible
[451.550998] Starting dynamic subtest: A-eDP1
[460.307895] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[460.320653] Starting dynamic subtest: B-eDP1
[469.039018] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[469.050765] Starting dynamic subtest: C-eDP1
[477.772922] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[477.784284] Starting dynamic subtest: D-eDP1
[486.503164] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[486.505387] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.911s)
[487.680756] [053/133] (634s left) kms_plane_multiple (2x-tiling-4)
[487.766287] Starting subtest: 2x-tiling-4
[487.771289] Subtest 2x-tiling-4: SKIP (0.000s)
[487.842651] [054/133] (634s left) kms_frontbuffer_tracking (fbc-tiling-4)
[487.933198] Starting subtest: fbc-tiling-4
[492.106130] Subtest fbc-tiling-4: SUCCESS (4.178s)
[493.301981] [055/133] (628s left) kms_flip (2x-nonexisting-fb-interruptible)
[493.403785] Starting subtest: 2x-nonexisting-fb-interruptible
[493.415297] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[493.526198] [056/133] (628s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[493.633478] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[494.666979] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.034s)
[494.789448] [057/133] (627s left) gem_exec_reloc (basic-range)
[494.855461] Subtest basic-range: SKIP (0.000s)
[494.923153] [058/133] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[495.028118] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[502.313403] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.290s)
[502.443734] [059/133] (619s left) gem_exec_whisper (basic-queues-forked)
[502.503538] Starting subtest: basic-queues-forked
[525.196768] Subtest basic-queues-forked: SUCCESS (22.690s)
[525.383772] [060/133] (596s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[525.483200] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[525.488188] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[525.557150] [061/133] (596s left) kms_flip (flip-vs-panning-vs-hang)
[525.654734] Starting subtest: flip-vs-panning-vs-hang
[525.657273] Starting dynamic subtest: A-eDP1
[576.906541] Dynamic subtest A-eDP1: SUCCESS (51.247s)
[576.916813] Starting dynamic subtest: D-eDP1
[616.839480] Dynamic subtest D-eDP1: SUCCESS (39.928s)
[616.847944] Subtest flip-vs-panning-vs-hang: SUCCESS (91.182s)
[618.018820] [062/133] (504s left) kms_cursor_legacy (torture-move)
[618.138937] Starting subtest: torture-move
[618.141259] Starting dynamic subtest: pipe-A
[624.058105] Dynamic subtest pipe-A: SUCCESS (5.917s)
[624.072178] Starting dynamic subtest: pipe-B
[630.732533] Dynamic subtest pipe-B: SUCCESS (6.673s)
[630.741775] Starting dynamic subtest: pipe-C
[638.568801] Dynamic subtest pipe-C: SUCCESS (7.834s)
[638.582973] Starting dynamic subtest: pipe-D
[645.048544] Dynamic subtest pipe-D: SUCCESS (6.476s)
[645.062097] Starting dynamic subtest: all-pipes
[652.271595] Dynamic subtest all-pipes: SUCCESS (7.223s)
[652.274340] Subtest torture-move: SUCCESS (34.134s)
[652.429141] [063/133] (469s left) kms_pm_dc (dc9-dpms)
[653.524253] Starting subtest: dc9-dpms
[654.939035] Subtest dc9-dpms: SUCCESS (1.416s)
[655.011005] [064/133] (467s left) kms_vrr (max-min)
[655.105110] Starting subtest: max-min
[655.112350] Subtest max-min: SKIP (0.000s)
[655.178019] [065/133] (467s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[655.240094] Starting subtest: single-wait-all-for-submit-signaled
[655.242763] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[655.338796] [066/133] (467s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[655.457487] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[655.460133] Starting dynamic subtest: pipe-A-eDP-1
[655.483842] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[655.496182] Starting dynamic subtest: pipe-B-eDP-1
[655.521334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[655.530479] Starting dynamic subtest: pipe-C-eDP-1
[655.555918] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[655.565166] Starting dynamic subtest: pipe-D-eDP-1
[655.591204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[655.596295] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[657.669720] [067/133] (464s left) prime_mmap_kms (buffer-sharing)
[657.754719] Starting subtest: buffer-sharing
[658.198964] Subtest buffer-sharing: SUCCESS (0.446s)
[659.023113] [068/133] (463s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[659.079330] Starting subtest: yf-tiled-to-vebox-y-tiled
[659.084374] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[659.261294] [069/133] (463s left) gem_exec_flush (basic-wb-set-default)
[659.315770] Starting subtest: basic-wb-set-default
[664.772349] Subtest basic-wb-set-default: SUCCESS (5.454s)
[664.972714] [070/133] (457s left) sysfs_defaults (readonly)
[665.028490] Starting subtest: readonly
[665.031603] Starting dynamic subtest: vecs0
[665.034756] Dynamic subtest vecs0: SUCCESS (0.000s)
[665.045177] Starting dynamic subtest: ccs0
[665.048306] Dynamic subtest ccs0: SUCCESS (0.000s)
[665.058198] Starting dynamic subtest: vcs0
[665.061179] Dynamic subtest vcs0: SUCCESS (0.000s)
[665.071013] Starting dynamic subtest: bcs0
[665.073742] Dynamic subtest bcs0: SUCCESS (0.000s)
[665.084486] Starting dynamic subtest: rcs0
[665.087034] Dynamic subtest rcs0: SUCCESS (0.000s)
[665.096463] Starting dynamic subtest: vcs1
[665.099247] Dynamic subtest vcs1: SUCCESS (0.001s)
[665.101891] Subtest readonly: SUCCESS (0.006s)
[665.143581] [071/133] (457s left) gen3_render_tiledy_blits
[665.249790] [072/133] (457s left) gem_exec_reloc (basic-write-wc-active)
[665.311241] Subtest basic-write-wc-active: SKIP (0.000s)
[665.386578] [073/133] (457s left) gem_ctx_isolation (preservation-reset)
[665.554510] Starting subtest: preservation-reset
[665.556925] Starting dynamic subtest: rcs0
[665.878398] Dynamic subtest rcs0: SUCCESS (0.327s)
[665.891042] Starting dynamic subtest: bcs0
[666.246467] Dynamic subtest bcs0: SUCCESS (0.367s)
[666.256358] Starting dynamic subtest: vcs0
[666.598402] Dynamic subtest vcs0: SUCCESS (0.351s)
[666.610807] Starting dynamic subtest: vcs1
[668.687289] Dynamic subtest vcs1: SUCCESS (2.087s)
[668.703763] Starting dynamic subtest: vecs0
[670.668835] Dynamic subtest vecs0: SUCCESS (1.981s)
[670.681406] Starting dynamic subtest: ccs0
[672.675203] Dynamic subtest ccs0: SUCCESS (2.005s)
[672.678206] Subtest preservation-reset: SUCCESS (7.127s)
[672.795796] [074/133] (450s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[672.849730] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[672.852290] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[672.949842] [075/133] (449s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[673.040526] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[673.044990] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[674.129236] [076/133] (448s left) gem_exec_params (secure-non-root)
[674.194400] Starting subtest: secure-non-root
[674.199504] Subtest secure-non-root: SKIP (0.000s)
[674.292328] [077/133] (448s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[674.381392] Starting subtest: x-tiled-64bpp-rotate-90
[674.403485] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s)
[674.507133] [078/133] (448s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[674.602340] Starting subtest: primary-y-tiled-reflect-x-180
[674.673098] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[674.777813] [079/133] (448s left) gem_mmap_wc (write-prefaulted)
[674.830131] Subtest write-prefaulted: SKIP (0.000s)
[674.901479] [080/133] (448s left) gem_create (create-valid-nonaligned)
[674.952766] Starting subtest: create-valid-nonaligned
[674.955526] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[675.150618] [081/133] (448s left) api_intel_allocator (execbuf-with-allocator)
[675.204460] Starting subtest: execbuf-with-allocator
[675.210399] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[675.320386] [082/133] (447s left) gem_partial_pwrite_pread (writes-after-reads)
[675.370378] Subtest writes-after-reads: SKIP (0.000s)
[675.437536] [083/133] (447s left) kms_cursor_crc (cursor-random-64x21)
[675.639615] Starting subtest: cursor-random-64x21
[675.688849] Subtest cursor-random-64x21: SKIP (0.042s)
[675.945945] [084/133] (447s left) gem_eio (reset-stress)
[676.177714] Starting subtest: reset-stress
[676.180035] Starting dynamic subtest: render
[681.147954] Dynamic subtest render: SUCCESS (4.967s)
[681.161609] Starting dynamic subtest: bsd1
[698.843334] Dynamic subtest bsd1: SUCCESS (17.693s)
[698.860415] Starting dynamic subtest: bsd2
[716.892254] Dynamic subtest bsd2: SUCCESS (18.047s)
[716.908789] Starting dynamic subtest: blt
[716.913322] Dynamic subtest blt: SKIP (0.000s)
[716.922760] Starting dynamic subtest: vebox
[734.889864] Dynamic subtest vebox: SUCCESS (17.995s)
[734.892649] Subtest reset-stress: SUCCESS (58.707s)
[736.394169] [085/133] (386s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[736.502444] Starting subtest: 4-tiled-64bpp-rotate-90
[736.522459] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[736.625454] [086/133] (386s left) kms_rotation_crc (multiplane-rotation)
[736.713729] Starting subtest: multiplane-rotation
[754.351022] Subtest multiplane-rotation: SUCCESS (17.638s)
[754.457831] [087/133] (368s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[754.562365] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[754.567068] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[754.656817] [088/133] (368s left) kms_addfb_basic (bo-too-small)
[754.766913] Starting subtest: bo-too-small
[754.769333] Subtest bo-too-small: SUCCESS (0.000s)
[754.859050] [089/133] (368s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[754.966716] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[761.807680] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.842s)
[761.935008] [090/133] (361s left) gem_ctx_persistence (legacy-engines-hostile)
[761.999179] Starting subtest: legacy-engines-hostile
[762.001789] Starting dynamic subtest: render
[762.070498] Dynamic subtest render: SUCCESS (0.070s)
[762.082458] Starting dynamic subtest: bsd1
[762.161955] Dynamic subtest bsd1: SUCCESS (0.089s)
[762.174509] Starting dynamic subtest: bsd2
[762.250910] Dynamic subtest bsd2: SUCCESS (0.086s)
[762.263678] Starting dynamic subtest: blt
[762.341637] Dynamic subtest blt: SUCCESS (0.088s)
[762.354180] Starting dynamic subtest: vebox
[762.432361] Dynamic subtest vebox: SUCCESS (0.088s)
[762.435242] Subtest legacy-engines-hostile: SUCCESS (0.434s)
[762.517118] [091/133] (361s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[762.617138] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[762.619645] Starting dynamic subtest: pipe-A-eDP-1
[762.716971] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[762.728928] Starting dynamic subtest: pipe-B-eDP-1
[763.829726] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s)
[763.835022] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.215s)
[765.030713] [092/133] (358s left) gem_wait (await)
[765.092484] Starting subtest: await
[765.095289] Starting dynamic subtest: all-engines
[766.187456] Dynamic subtest all-engines: SUCCESS (1.095s)
[766.206038] Starting dynamic subtest: rcs0
[767.247494] Dynamic subtest rcs0: SUCCESS (1.057s)
[767.265387] Starting dynamic subtest: bcs0
[768.308349] Dynamic subtest bcs0: SUCCESS (1.059s)
[768.326207] Starting dynamic subtest: vcs0
[769.366689] Dynamic subtest vcs0: SUCCESS (1.055s)
[769.384215] Starting dynamic subtest: vcs1
[770.424321] Dynamic subtest vcs1: SUCCESS (1.056s)
[770.441819] Starting dynamic subtest: vecs0
[771.482622] Dynamic subtest vecs0: SUCCESS (1.055s)
[771.500439] Starting dynamic subtest: ccs0
[772.544871] Dynamic subtest ccs0: SUCCESS (1.060s)
[772.547809] Subtest await: SUCCESS (7.453s)
[772.752755] [093/133] (350s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[772.858849] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[772.863595] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[772.949720] [094/133] (350s left) gem_exec_schedule (timeslicing)
[773.027311] Starting subtest: timeslicing
[773.029733] Starting dynamic subtest: rcs0
[773.043085] Dynamic subtest rcs0: SUCCESS (0.025s)
[773.060009] Starting dynamic subtest: bcs0
[773.069438] Dynamic subtest bcs0: SUCCESS (0.024s)
[773.081527] Starting dynamic subtest: vcs0
[773.091719] Dynamic subtest vcs0: SUCCESS (0.021s)
[773.104478] Starting dynamic subtest: vcs1
[773.113276] Dynamic subtest vcs1: SUCCESS (0.020s)
[773.123399] Starting dynamic subtest: vecs0
[773.134413] Dynamic subtest vecs0: SUCCESS (0.020s)
[773.144244] Starting dynamic subtest: ccs0
[773.158524] Dynamic subtest ccs0: SUCCESS (0.023s)
[773.161243] Subtest timeslicing: SUCCESS (0.141s)
[774.345921] [095/133] (349s left) kms_fbcon_fbt (fbc-suspend)
[774.402149] Starting subtest: fbc-suspend
[824.316055] Subtest fbc-suspend: SUCCESS (19.847s)
[827.773157] [096/133] (298s left) gem_ccs (block-multicopy-inplace)
[827.840756] Starting subtest: block-multicopy-inplace
[827.845294] Subtest block-multicopy-inplace: SKIP (0.000s)
[827.938329] [097/133] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[828.039688] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[828.043616] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[828.143078] [098/133] (297s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[828.261844] Starting subtest: short-flip-before-cursor-toggle
[829.186133] Subtest short-flip-before-cursor-toggle: SUCCESS (0.921s)
[830.049869] [099/133] (295s left) gem_userptr_blits (process-exit-busy)
[830.125744] Starting subtest: process-exit-busy
[830.138289] Subtest process-exit-busy: SUCCESS (0.013s)
[830.273588] [100/133] (295s left) prime_mmap (test_map_unmap)
[830.323386] Starting subtest: test_map_unmap
[830.325625] Starting dynamic subtest: test_map_unmap-smem
[830.360353] Dynamic subtest test_map_unmap-smem: SUCCESS (0.038s)
[830.362883] Subtest test_map_unmap: SUCCESS (0.039s)
[830.467950] [101/133] (295s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[830.595998] Starting subtest: short-flip-after-cursor-toggle
[831.520226] Subtest short-flip-after-cursor-toggle: SUCCESS (0.923s)
[832.409570] [102/133] (293s left) gen9_exec_parse (shadow-peek)
[832.465792] Subtest shadow-peek: SKIP (0.000s)
[832.541836] [103/133] (293s left) gen7_exec_parse (chained-batch)
[832.599500] Subtest chained-batch: SKIP (0.000s)
[832.676081] [104/133] (293s left) gem_exec_schedule (in-order)
[832.754619] Starting subtest: in-order
[832.756581] Starting dynamic subtest: rcs0
[832.860679] Dynamic subtest rcs0: SUCCESS (0.108s)
[832.873399] Starting dynamic subtest: vcs0
[832.952482] Dynamic subtest vcs0: SUCCESS (0.090s)
[832.965655] Starting dynamic subtest: vcs1
[833.034537] Dynamic subtest vcs1: SUCCESS (0.081s)
[833.049104] Starting dynamic subtest: vecs0
[833.111450] Dynamic subtest vecs0: SUCCESS (0.076s)
[833.124809] Starting dynamic subtest: ccs0
[833.199035] Dynamic subtest ccs0: SUCCESS (0.087s)
[833.201465] Subtest in-order: SUCCESS (0.447s)
[834.571768] [105/133] (291s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[834.697088] Starting subtest: cursorB-vs-flipB-legacy
[834.701489] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[834.851514] [106/133] (291s left) kms_pm_rpm (system-suspend-idle)
[836.585369] Starting subtest: system-suspend-idle
[859.557614] Subtest system-suspend-idle: SUCCESS (7.835s)
[860.955318] [107/133] (266s left) gem_exec_whisper (basic-fds-all)
[861.025684] Starting subtest: basic-fds-all
[872.361281] Subtest basic-fds-all: SUCCESS (11.332s)
[872.545195] [108/133] (254s left) kms_selftest (drm_plane_helper)
[872.583537] Starting subtest: drm_plane_helper
[872.632028] Starting dynamic subtest: drm_test_check_plane_state
[872.728989] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.098s)
[872.739856] Starting dynamic subtest: drm_test_check_invalid_plane_state
[872.822869] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.094s)
[872.824840] Subtest drm_plane_helper: SUCCESS (0.239s)
[872.993880] [109/133] (254s left) gem_exec_async (concurrent-writes)
[873.065307] Starting subtest: concurrent-writes
[873.067658] Starting dynamic subtest: rcs0
[873.090767] Dynamic subtest rcs0: SUCCESS (0.025s)
[873.101866] Starting dynamic subtest: bcs0
[873.104176] Dynamic subtest bcs0: SUCCESS (0.010s)
[873.114798] Starting dynamic subtest: vcs0
[873.116659] Dynamic subtest vcs0: SUCCESS (0.007s)
[873.126689] Starting dynamic subtest: vcs1
[873.128924] Dynamic subtest vcs1: SUCCESS (0.008s)
[873.138798] Starting dynamic subtest: vecs0
[873.140942] Dynamic subtest vecs0: SUCCESS (0.007s)
[873.150556] Starting dynamic subtest: ccs0
[873.152781] Dynamic subtest ccs0: SUCCESS (0.007s)
[873.154915] Subtest concurrent-writes: SUCCESS (0.068s)
[873.379687] [110/133] (254s left) prime_busy (before)
[873.444375] Starting subtest: before
[873.450367] Starting dynamic subtest: rcs0
[873.482085] Dynamic subtest rcs0: SUCCESS (0.034s)
[873.494715] Starting dynamic subtest: bcs0
[873.535476] Dynamic subtest bcs0: SUCCESS (0.052s)
[873.546469] Starting dynamic subtest: vcs0
[873.578926] Dynamic subtest vcs0: SUCCESS (0.043s)
[873.588831] Starting dynamic subtest: vcs1
[873.619624] Dynamic subtest vcs1: SUCCESS (0.040s)
[873.629578] Starting dynamic subtest: vecs0
[873.662321] Dynamic subtest vecs0: SUCCESS (0.042s)
[873.672489] Starting dynamic subtest: ccs0
[873.705163] Dynamic subtest ccs0: SUCCESS (0.042s)
[873.813572] Subtest before: SUCCESS (0.368s)
[873.891239] [111/133] (253s left) kms_plane (plane-position-covered)
[873.998900] Starting subtest: plane-position-covered
[874.538081] Starting dynamic subtest: pipe-A-plane-1
[875.842879] Dynamic subtest pipe-A-plane-1: SUCCESS (1.305s)
[875.854136] Starting dynamic subtest: pipe-A-plane-2
[877.159436] Dynamic subtest pipe-A-plane-2: SUCCESS (1.314s)
[877.170558] Starting dynamic subtest: pipe-A-plane-3
[878.484294] Dynamic subtest pipe-A-plane-3: SUCCESS (1.327s)
[878.499402] Starting dynamic subtest: pipe-A-plane-4
[879.822404] Dynamic subtest pipe-A-plane-4: SUCCESS (1.335s)
[879.833088] Starting dynamic subtest: pipe-A-plane-5
[879.847167] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[881.085168] Starting dynamic subtest: pipe-B-plane-1
[882.434391] Dynamic subtest pipe-B-plane-1: SUCCESS (1.355s)
[882.446307] Starting dynamic subtest: pipe-B-plane-2
[883.717237] Dynamic subtest pipe-B-plane-2: SUCCESS (1.282s)
[883.728240] Starting dynamic subtest: pipe-B-plane-3
[885.009819] Dynamic subtest pipe-B-plane-3: SUCCESS (1.291s)
[885.021348] Starting dynamic subtest: pipe-B-plane-4
[886.312024] Dynamic subtest pipe-B-plane-4: SUCCESS (1.301s)
[886.322938] Starting dynamic subtest: pipe-B-plane-5
[886.337098] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[886.339437] Subtest plane-position-covered: SUCCESS (12.338s)
[887.186415] [112/133] (240s left) kms_color_pipeline (plane-lut1d)
[887.307900] Starting subtest: plane-lut1d
[887.525339] Starting dynamic subtest: pipe-A-plane-0
[887.691444] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[887.701990] Starting dynamic subtest: pipe-A-plane-1
[887.858069] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[887.868162] Starting dynamic subtest: pipe-A-plane-2
[888.024768] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[889.196684] Starting dynamic subtest: pipe-B-plane-0
[889.364391] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[889.374995] Starting dynamic subtest: pipe-B-plane-1
[889.520865] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[889.531544] Starting dynamic subtest: pipe-B-plane-2
[889.686662] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[890.955167] Starting dynamic subtest: pipe-C-plane-0
[891.112782] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[891.123666] Starting dynamic subtest: pipe-C-plane-1
[891.279563] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[891.290048] Starting dynamic subtest: pipe-C-plane-2
[891.423479] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[892.657766] Starting dynamic subtest: pipe-D-plane-0
[892.804332] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[892.815040] Starting dynamic subtest: pipe-D-plane-1
[892.970991] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[892.981760] Starting dynamic subtest: pipe-D-plane-2
[893.127053] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[893.419700] Subtest plane-lut1d: SUCCESS (6.110s)
[894.219500] [113/133] (233s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[894.320976] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[894.325222] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[894.420749] [114/133] (233s left) kms_content_protection (lic-type-1)
[894.568854] Starting subtest: lic-type-1
[894.573274] Subtest lic-type-1: SKIP (0.000s)
[894.696355] [115/133] (233s left) syncobj_wait (invalid-signal-zero-handles)
[894.763660] Starting subtest: invalid-signal-zero-handles
[894.765878] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[894.852549] [116/133] (232s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[894.950880] Starting subtest: plane-upscale-factor-0-25-with-rotation
[894.953179] Starting dynamic subtest: pipe-A
[895.174896] Dynamic subtest pipe-A: SUCCESS (0.227s)
[895.184864] Starting dynamic subtest: pipe-B
[896.506548] Dynamic subtest pipe-B: SUCCESS (1.330s)
[896.516686] Starting dynamic subtest: pipe-C
[897.846452] Dynamic subtest pipe-C: SUCCESS (1.339s)
[897.857486] Starting dynamic subtest: pipe-D
[899.173216] Dynamic subtest pipe-D: SUCCESS (1.325s)
[899.175604] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.225s)
[900.354524] [117/133] (227s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[900.416143] Starting subtest: etime-multi-wait-all-available-unsubmitted
[900.523467] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[900.612158] [118/133] (227s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[900.988630] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[901.758399] [119/133] (226s left) dumb_buffer (create-valid-dumb)
[901.821149] Starting subtest: create-valid-dumb
[901.823244] Subtest create-valid-dumb: SUCCESS (0.000s)
[901.908274] [120/133] (226s left) sw_sync (alloc_merge_fence)
[901.950396] Starting subtest: alloc_merge_fence
[901.952578] Subtest alloc_merge_fence: SUCCESS (0.000s)
[902.005681] [121/133] (225s left) kms_psr (fbc-psr-sprite-render)
[902.114048] Starting subtest: fbc-psr-sprite-render
[902.116218] Starting dynamic subtest: eDP-1
[902.120223] Dynamic subtest eDP-1: SKIP (0.000s)
[902.124217] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[902.195004] [122/133] (225s left) kms_big_fb (linear-64bpp-rotate-180)
[902.289874] Starting subtest: linear-64bpp-rotate-180
[903.924532] Subtest linear-64bpp-rotate-180: SUCCESS (1.635s)
[904.096025] [123/133] (223s left) gem_userptr_blits (coherency-sync)
[904.154770] Starting subtest: coherency-sync
[904.672995] Subtest coherency-sync: SKIP (0.476s)
[904.785169] [124/133] (223s left) i915_drm_fdinfo (virtual-busy-idle-all)
[904.874201] Starting subtest: virtual-busy-idle-all
[904.878816] Subtest virtual-busy-idle-all: SKIP (0.000s)
[904.966167] [125/133] (223s left) sw_sync (alloc_timeline)
[905.011266] Starting subtest: alloc_timeline
[905.014148] Subtest alloc_timeline: SUCCESS (0.000s)
[905.072384] [126/133] (223s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[905.186036] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[908.901802] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.720s)
[910.077686] [127/133] (218s left) kms_vblank (ts-continuation-idle)
[910.166302] Starting subtest: ts-continuation-idle
[910.168553] Starting dynamic subtest: pipe-A-eDP-1
[910.569228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[910.583796] Starting dynamic subtest: pipe-D-eDP-1
[911.653090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.083s)
[911.655328] Subtest ts-continuation-idle: SUCCESS (1.488s)
[912.528110] [128/133] (215s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[912.635964] Starting subtest: fbc-indfb-scaledprimary
[915.613516] Subtest fbc-indfb-scaledprimary: SUCCESS (2.979s)
[916.759399] [129/133] (211s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[916.857639] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[923.879621] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.025s)
[924.023607] [130/133] (204s left) gem_lmem_swapping (verify-random)
[924.070012] Subtest verify-random: SKIP (0.000s)
[924.120362] [131/133] (204s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[924.230238] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[924.234459] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[924.331013] [132/133] (204s left) vgem_basic (unload)
[924.369557] Starting subtest: unload
[953.380025] Subtest unload: SUCCESS (29.014s)
[953.497739] [133/133] (175s left) kms_addfb_basic (clobberred-modifier)
[953.557788] Starting subtest: clobberred-modifier
[953.562160] Subtest clobberred-modifier: SKIP (0.000s)
[953.699447] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_cursor_edge_walk
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: prime_self_import
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_invalid_mode
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: i915_query
results: parsing output: 29/ for test: kms_draw_crc
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_caching
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_spin_batch
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_chamelium_audio
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: api_intel_bb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: i915_pm_rpm
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: kms_vrr
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: prime_mmap_kms
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: sysfs_defaults
results: parsing output: 70/ for test: gen3_render_tiledy_blits
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_ctx_isolation
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: gem_create
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: gem_partial_pwrite_pread
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: gem_wait
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_fbcon_fbt
results: parsing output: 95/ for test: gem_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: prime_mmap
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: gen7_exec_parse
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: kms_selftest
results: parsing output: 108/ for test: gem_exec_async
results: parsing output: 109/ for test: prime_busy
results: parsing output: 110/ for test: kms_plane
results: parsing output: 111/ for test: kms_color_pipeline
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: dumb_buffer
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: vgem_basic
results: parsing output: 132/ for test: kms_addfb_basic
Done.