[59.490341] Initializing watchdogs [59.490386] /dev/watchdog0 [59.505712] [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] [59.512741] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.515061] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.518461] [001/133] (960s left) kms_frontbuffer_tracking (psr-slowdraw) [59.657124] Starting subtest: psr-slowdraw [84.888835] Subtest psr-slowdraw: SUCCESS (25.169s) [85.019850] [002/133] (935s left) kms_flip (2x-flip-vs-modeset-vs-hang) [85.120462] Starting subtest: 2x-flip-vs-modeset-vs-hang [85.124343] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s) [85.227802] [003/133] (934s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [85.318983] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [85.323286] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [85.411386] [004/133] (934s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [85.509621] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [85.514272] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [85.634146] [005/133] (934s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [85.714976] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [85.716975] Starting dynamic subtest: pipe-A-eDP-1 [85.736784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [85.745958] Starting dynamic subtest: pipe-B-eDP-1 [85.764581] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [85.771783] Starting dynamic subtest: pipe-C-eDP-1 [85.789688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [85.796698] Starting dynamic subtest: pipe-D-eDP-1 [85.815950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [85.819574] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s) [88.180499] [006/133] (932s left) kms_big_fb (y-tiled-addfb-size-overflow) [88.289675] Starting subtest: y-tiled-addfb-size-overflow [88.294450] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [88.397746] [007/133] (931s left) syncobj_wait (invalid-reset-illegal-handle) [88.460791] Starting subtest: invalid-reset-illegal-handle [88.462668] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [88.561640] [008/133] (931s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [88.655345] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [89.468696] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.815s) [89.636112] [009/133] (930s left) gem_mmap_offset (blt-coherency) [89.694848] Starting subtest: blt-coherency [89.702362] Subtest blt-coherency: SUCCESS (0.009s) [89.833749] [010/133] (930s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [89.936201] Starting subtest: sprite-rotation-90-pos-100-0 [89.940910] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [90.006562] [011/133] (930s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [90.382322] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [91.195793] [012/133] (929s left) sw_sync (sync_busy_fork_unixsocket) [91.230278] Starting subtest: sync_busy_fork_unixsocket [91.235904] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s) [91.289823] [013/133] (929s left) syncobj_wait (wait-any-interrupted) [91.334811] Starting subtest: wait-any-interrupted [91.441404] Subtest wait-any-interrupted: SUCCESS (0.106s) [91.523843] [014/133] (928s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [91.628527] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [91.632781] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [91.723442] [015/133] (928s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [91.818292] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [91.822679] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [91.887183] [016/133] (928s left) gen9_exec_parse (bb-start-param) [91.951766] Subtest bb-start-param: SKIP (0.000s) [92.030439] [017/133] (928s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [92.118230] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [92.120704] Starting dynamic subtest: pipe-A-eDP-1 [92.143857] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [92.153499] Starting dynamic subtest: pipe-B-eDP-1 [92.175120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [92.182339] Starting dynamic subtest: pipe-C-eDP-1 [92.204051] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [92.211290] Starting dynamic subtest: pipe-D-eDP-1 [92.233188] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [92.237538] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [94.394187] [018/133] (926s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [94.502251] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [95.293063] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s) [95.474466] [019/133] (925s left) kms_draw_crc (draw-method-mmap-cpu) [95.568014] Starting subtest: draw-method-mmap-cpu [95.570029] Starting dynamic subtest: xrgb8888-untiled [95.832401] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s) [95.840764] Starting dynamic subtest: rgb565-untiled [96.043765] Dynamic subtest rgb565-untiled: SUCCESS (0.211s) [96.051663] Starting dynamic subtest: xrgb2101010-untiled [96.265510] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [96.274703] Starting dynamic subtest: xbgr16161616f-untiled [96.499185] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [96.506779] Starting dynamic subtest: xrgb8888-xtiled [96.632225] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [96.640917] Starting dynamic subtest: rgb565-xtiled [96.765852] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [96.774846] Starting dynamic subtest: xrgb2101010-xtiled [96.898908] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [96.906494] Starting dynamic subtest: xbgr16161616f-xtiled [97.020850] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [97.028359] Starting dynamic subtest: xrgb8888-4tiled [97.154717] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [97.162416] Starting dynamic subtest: rgb565-4tiled [97.299383] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [97.307568] Starting dynamic subtest: xrgb2101010-4tiled [97.432468] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [97.441324] Starting dynamic subtest: xbgr16161616f-4tiled [97.576988] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [97.578990] Subtest draw-method-mmap-cpu: SUCCESS (2.011s) [97.676587] [020/133] (923s left) kms_content_protection (legacy-hdcp14) [97.824395] Starting subtest: legacy-hdcp14 [97.828148] Subtest legacy-hdcp14: SKIP (0.000s) [97.940523] [021/133] (922s left) kms_prop_blob (blob-prop-validate) [97.999575] Starting subtest: blob-prop-validate [98.001652] Subtest blob-prop-validate: SUCCESS (0.000s) [98.106346] [022/133] (922s left) syncobj_wait (wait-all-for-submit-complex) [98.157337] Starting subtest: wait-all-for-submit-complex [98.372345] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [98.444184] [023/133] (922s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [100.472600] Starting subtest: modeset-non-lpsp-stress-no-wait [100.522644] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s) [100.850056] [024/133] (920s left) kms_cursor_edge_walk (256x256-top-bottom) [100.938567] Starting subtest: 256x256-top-bottom [100.940798] Starting dynamic subtest: pipe-A-eDP-1 [104.419675] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s) [104.429879] Starting dynamic subtest: pipe-D-eDP-1 [107.538030] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s) [107.540205] Subtest 256x256-top-bottom: SUCCESS (6.598s) [108.341975] [025/133] (912s left) gem_ctx_persistence (legacy-engines-queued) [108.405054] Starting subtest: legacy-engines-queued [108.407326] Starting dynamic subtest: render [108.486329] Dynamic subtest render: SUCCESS (0.081s) [108.497170] Starting dynamic subtest: bsd1 [110.246671] Dynamic subtest bsd1: SUCCESS (1.756s) [110.257917] Starting dynamic subtest: bsd2 [112.291446] Dynamic subtest bsd2: SUCCESS (2.042s) [112.302945] Starting dynamic subtest: blt [112.353485] Dynamic subtest blt: SUCCESS (0.061s) [112.364207] Starting dynamic subtest: vebox [114.275751] Dynamic subtest vebox: SUCCESS (1.918s) [114.278854] Subtest legacy-engines-queued: SUCCESS (5.869s) [114.353182] [026/133] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [114.461720] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [121.237055] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.779s) [121.381156] [027/133] (899s left) gem_exec_await (wide-all) [121.613689] Starting subtest: wide-all [145.152084] Subtest wide-all: SUCCESS (23.537s) [145.336225] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true [145.340359] [028/133] (875s left) gem_exec_schedule (u-semaphore-user) [145.447988] Starting subtest: u-semaphore-user [145.509056] Subtest u-semaphore-user: SUCCESS (0.062s) [147.311095] [029/133] (873s left) vgem_basic (bad-pad) [147.351934] Starting subtest: bad-pad [147.354403] Subtest bad-pad: SUCCESS (0.000s) [147.407855] [030/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [147.505511] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [147.509566] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [147.612612] [031/133] (873s left) kms_psr (psr-primary-mmap-cpu) [147.696865] Starting subtest: psr-primary-mmap-cpu [147.699184] Starting dynamic subtest: eDP-1 [149.455127] Dynamic subtest eDP-1: SUCCESS (1.759s) [149.457556] Subtest psr-primary-mmap-cpu: SUCCESS (1.760s) [150.319183] [032/133] (870s left) gem_mmap_gtt (basic) [150.375266] Subtest basic: SKIP (0.000s) [150.436810] [033/133] (870s left) gem_ctx_param (non-root-set) [150.493878] Starting subtest: non-root-set [150.526082] Subtest non-root-set: SUCCESS (0.032s) [150.609406] [034/133] (870s left) kms_psr (psr2-cursor-render) [150.699787] Starting subtest: psr2-cursor-render [150.702122] Starting dynamic subtest: eDP-1 [152.390891] Dynamic subtest eDP-1: SUCCESS (1.692s) [152.393159] Subtest psr2-cursor-render: SUCCESS (1.693s) [153.274417] [035/133] (868s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [153.366175] Starting subtest: fbc-rgb565-draw-mmap-cpu [157.380778] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.017s) [158.571485] [036/133] (862s left) gem_close_race (multigpu-basic-process) [158.641811] Starting subtest: multigpu-basic-process [158.646347] Subtest multigpu-basic-process: SKIP (0.000s) [158.879953] [037/133] (862s left) gem_exec_nop (basic-series) [158.964149] Starting subtest: basic-series [175.304767] Subtest basic-series: SUCCESS (16.347s) [175.530746] [038/133] (845s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [175.631554] Starting subtest: bad-pixel-format-yf-tiled-ccs [175.633871] Starting dynamic subtest: pipe-A-eDP-1 [175.656784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [175.666209] Starting dynamic subtest: pipe-B-eDP-1 [175.687783] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [175.696060] Starting dynamic subtest: pipe-C-eDP-1 [175.716736] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [175.725280] Starting dynamic subtest: pipe-D-eDP-1 [175.748311] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [175.752355] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s) [177.839592] [039/133] (843s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [177.899556] Subtest writes-after-reads: SKIP (0.000s) [177.972561] [040/133] (843s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [178.076497] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [185.366138] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.294s) [185.492134] [041/133] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [185.588588] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [185.592824] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [185.694308] [042/133] (835s left) kms_color (degamma) [185.785718] Starting subtest: degamma [185.787648] Starting dynamic subtest: pipe-A-eDP-1 [186.550290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s) [186.560020] Starting dynamic subtest: pipe-B-eDP-1 [187.967532] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s) [187.976629] Starting dynamic subtest: pipe-C-eDP-1 [189.335528] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s) [189.345244] Starting dynamic subtest: pipe-D-eDP-1 [190.672064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s) [190.674510] Subtest degamma: SUCCESS (4.888s) [191.473248] [043/133] (830s left) gem_userptr_blits (coherency-sync) [191.531859] Starting subtest: coherency-sync [191.681530] Subtest coherency-sync: SKIP (0.110s) [191.782194] [044/133] (829s left) kms_joiner (basic-big-joiner) [191.917231] Starting subtest: basic-big-joiner [191.921451] Subtest basic-big-joiner: SKIP (0.000s) [191.981174] [045/133] (829s left) kms_cursor_crc (cursor-offscreen-512x512) [192.261717] Starting subtest: cursor-offscreen-512x512 [192.265984] Subtest cursor-offscreen-512x512: SKIP (0.001s) [192.418212] [046/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [192.506854] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [192.510219] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [192.603632] [047/133] (829s left) gem_eio (reset-stress) [192.834088] Starting subtest: reset-stress [192.836284] Starting dynamic subtest: render [197.797050] Dynamic subtest render: SUCCESS (4.960s) [197.813114] Starting dynamic subtest: bsd1 [215.814650] Dynamic subtest bsd1: SUCCESS (18.014s) [215.830433] Starting dynamic subtest: bsd2 [233.826244] Dynamic subtest bsd2: SUCCESS (18.011s) [233.840108] Starting dynamic subtest: blt [233.845495] Dynamic subtest blt: SKIP (0.000s) [233.854303] Starting dynamic subtest: vebox [251.801068] Dynamic subtest vebox: SUCCESS (17.972s) [251.803669] Subtest reset-stress: SUCCESS (58.962s) [253.296785] [048/133] (768s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [253.405934] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [253.431789] Starting dynamic subtest: pipe-A-plane-0 [254.121862] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s) [254.130848] Starting dynamic subtest: pipe-A-plane-3 [254.553433] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s) [255.659851] Starting dynamic subtest: pipe-B-plane-0 [256.385408] Dynamic subtest pipe-B-plane-0: SUCCESS (0.733s) [256.396734] Starting dynamic subtest: pipe-B-plane-3 [256.807102] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s) [257.121633] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.715s) [257.965391] [049/133] (763s left) gem_exec_schedule (preempt-contexts) [258.042688] Starting subtest: preempt-contexts [258.044670] Starting dynamic subtest: rcs0 [258.089872] Dynamic subtest rcs0: SUCCESS (0.056s) [258.099764] Starting dynamic subtest: bcs0 [258.147250] Dynamic subtest bcs0: SUCCESS (0.055s) [258.157917] Starting dynamic subtest: vcs0 [258.193063] Dynamic subtest vcs0: SUCCESS (0.047s) [258.202882] Starting dynamic subtest: vcs1 [258.242071] Dynamic subtest vcs1: SUCCESS (0.048s) [258.251451] Starting dynamic subtest: vecs0 [258.302058] Dynamic subtest vecs0: SUCCESS (0.059s) [258.311754] Starting dynamic subtest: ccs0 [258.358550] Dynamic subtest ccs0: SUCCESS (0.056s) [258.360770] Subtest preempt-contexts: SUCCESS (0.326s) [259.422428] [050/133] (762s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [259.507029] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [259.509175] Starting dynamic subtest: pipe-A-eDP-1 [259.569600] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [259.586161] Starting dynamic subtest: pipe-B-eDP-1 [259.628719] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s) [259.638079] Starting dynamic subtest: pipe-C-eDP-1 [259.687443] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s) [259.696390] Starting dynamic subtest: pipe-D-eDP-1 [259.749521] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s) [259.751911] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.244s) [262.000793] [051/133] (759s left) kms_lease (lease-get) [262.097651] Starting subtest: lease-get [262.100474] Starting dynamic subtest: pipe-A-eDP-1 [262.102944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [262.113982] Starting dynamic subtest: pipe-B-eDP-1 [262.116177] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [262.125305] Starting dynamic subtest: pipe-C-eDP-1 [262.127475] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [262.135959] Starting dynamic subtest: pipe-D-eDP-1 [262.138067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [262.140133] Subtest lease-get: SUCCESS (0.012s) [262.238829] [052/133] (759s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [262.298679] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [262.401604] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s) [262.488438] [053/133] (759s left) syncobj_timeline (invalid-single-wait-unsubmitted) [262.541869] Starting subtest: invalid-single-wait-unsubmitted [262.544109] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [262.666430] [054/133] (759s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [262.718626] Starting subtest: etime-single-wait-for-submit-submitted [262.824370] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s) [262.902446] [055/133] (759s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [262.995916] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [263.000536] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [264.127126] [056/133] (758s left) kms_psr (fbc-pr-cursor-render) [264.213139] Starting subtest: fbc-pr-cursor-render [264.217413] Subtest fbc-pr-cursor-render: SKIP (0.000s) [264.282613] [057/133] (757s left) kms_getfb (getfb2-handle-not-fb) [264.367837] Starting subtest: getfb2-handle-not-fb [264.370086] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [264.480276] [058/133] (757s left) gem_exec_flush (basic-uc-rw-default) [264.551971] Starting subtest: basic-uc-rw-default [270.006244] Subtest basic-uc-rw-default: SUCCESS (5.454s) [270.196183] [059/133] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [270.304100] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [270.308261] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [270.417951] [060/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [270.507446] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [270.511704] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [270.597888] [061/133] (751s left) api_intel_bb (misplaced-blitter) [270.644376] Starting subtest: misplaced-blitter [270.649692] Subtest misplaced-blitter: SUCCESS (0.008s) [270.754075] [062/133] (751s left) kms_psr2_sf (pr-cursor-plane-update-sf) [270.845438] Starting subtest: pr-cursor-plane-update-sf [270.849605] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [270.914165] [063/133] (751s left) kms_async_flips (test-time-stamp) [271.005553] Starting subtest: test-time-stamp [271.395645] Starting dynamic subtest: pipe-A-eDP-1 [272.146219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s) [272.530657] Starting dynamic subtest: pipe-B-eDP-1 [273.273557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s) [273.652891] Starting dynamic subtest: pipe-C-eDP-1 [274.413413] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [274.776967] Starting dynamic subtest: pipe-D-eDP-1 [275.540128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s) [275.542451] Subtest test-time-stamp: SUCCESS (4.534s) [276.704692] [064/133] (745s left) kms_psr (fbc-psr-cursor-render) [276.799113] Starting subtest: fbc-psr-cursor-render [276.801446] Starting dynamic subtest: eDP-1 [276.805857] Dynamic subtest eDP-1: SKIP (0.000s) [276.810287] Subtest fbc-psr-cursor-render: SKIP (0.001s) [276.871056] [065/133] (745s left) gem_ctx_shared (q-independent) [276.933315] Starting subtest: Q-independent [276.935737] Starting dynamic subtest: rcs0 [276.992137] Dynamic subtest rcs0: SUCCESS (0.058s) [277.002136] Starting dynamic subtest: vcs0 [277.038350] Dynamic subtest vcs0: SUCCESS (0.045s) [277.051258] Starting dynamic subtest: vcs1 [277.080075] Dynamic subtest vcs1: SUCCESS (0.041s) [277.090426] Starting dynamic subtest: vecs0 [277.124433] Dynamic subtest vecs0: SUCCESS (0.044s) [277.135730] Starting dynamic subtest: ccs0 [277.179053] Dynamic subtest ccs0: SUCCESS (0.054s) [277.181374] Subtest Q-independent: SUCCESS (0.246s) [278.363609] [066/133] (744s left) kms_addfb_basic (bad-pitch-65536) [278.423083] Starting subtest: bad-pitch-65536 [278.425106] Subtest bad-pitch-65536: SUCCESS (0.000s) [278.559586] [067/133] (744s left) gem_userptr_blits (invalid-mmap-offset-unsync) [278.638541] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [278.757772] [068/133] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [278.855614] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [283.390269] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.540s) [284.600760] [069/133] (738s left) perf_pmu (busy-no-semaphores) [284.639926] Starting subtest: busy-no-semaphores [284.642164] Starting dynamic subtest: rcs0 [285.205311] Dynamic subtest rcs0: SUCCESS (0.564s) [285.217081] Starting dynamic subtest: bcs0 [285.756423] Dynamic subtest bcs0: SUCCESS (0.548s) [285.778480] Starting dynamic subtest: vcs0 [286.308580] Dynamic subtest vcs0: SUCCESS (0.549s) [286.320361] Starting dynamic subtest: vcs1 [287.816072] Dynamic subtest vcs1: SUCCESS (1.503s) [287.827653] Starting dynamic subtest: vecs0 [289.800787] Dynamic subtest vecs0: SUCCESS (1.982s) [289.812840] Starting dynamic subtest: ccs0 [291.784431] Dynamic subtest ccs0: SUCCESS (1.981s) [291.787563] Subtest busy-no-semaphores: SUCCESS (7.145s) [291.901912] [070/133] (730s left) gem_exec_params (dr1-dirt) [291.966928] Starting subtest: DR1-dirt [291.969194] Subtest DR1-dirt: SUCCESS (0.000s) [292.077103] [071/133] (730s left) kms_universal_plane (cursor-fb-leak) [292.170593] Starting subtest: cursor-fb-leak [292.172458] Starting dynamic subtest: pipe-A-eDP-1 [292.520094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.351s) [292.530634] Starting dynamic subtest: pipe-B-eDP-1 [293.911024] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s) [293.923925] Starting dynamic subtest: pipe-C-eDP-1 [295.227999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.315s) [295.240269] Starting dynamic subtest: pipe-D-eDP-1 [296.564649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s) [296.567088] Subtest cursor-fb-leak: SUCCESS (4.397s) [297.723458] [072/133] (725s left) kms_flip (modeset-vs-vblank-race-interruptible) [297.821520] Starting subtest: modeset-vs-vblank-race-interruptible [297.823913] Starting dynamic subtest: A-eDP1 [302.551078] Dynamic subtest A-eDP1: SUCCESS (4.728s) [302.567275] Starting dynamic subtest: B-eDP1 [307.200989] Dynamic subtest B-eDP1: SUCCESS (4.647s) [307.212222] Starting dynamic subtest: C-eDP1 [311.809117] Dynamic subtest C-eDP1: SUCCESS (4.606s) [311.819555] Starting dynamic subtest: D-eDP1 [316.358977] Dynamic subtest D-eDP1: SUCCESS (4.548s) [316.365259] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.541s) [317.531043] [073/133] (705s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [317.633445] Starting subtest: plane-downscale-factor-0-5-with-rotation [317.635872] Starting dynamic subtest: pipe-A [317.653311] Dynamic subtest pipe-A: SKIP (0.018s) [317.664726] Starting dynamic subtest: pipe-B [317.689321] Dynamic subtest pipe-B: SKIP (0.035s) [317.698872] Starting dynamic subtest: pipe-C [317.724869] Dynamic subtest pipe-C: SKIP (0.034s) [317.734429] Starting dynamic subtest: pipe-D [317.755519] Dynamic subtest pipe-D: SKIP (0.031s) [317.759267] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.120s) [317.859677] [074/133] (705s left) kms_plane_alpha_blend (constant-alpha-min) [317.960346] Starting subtest: constant-alpha-min [318.250371] Starting dynamic subtest: pipe-A-eDP-1 [319.006094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s) [319.015927] Starting dynamic subtest: pipe-D-eDP-1 [320.488091] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.479s) [320.490426] Subtest constant-alpha-min: SUCCESS (2.527s) [321.291109] [075/133] (701s left) gem_lmem_swapping (verify-random) [321.340238] Subtest verify-random: SKIP (0.000s) [321.385248] [076/133] (701s left) kms_setmode (invalid-clone-exclusive-crtc) [321.440692] Starting subtest: invalid-clone-exclusive-crtc [321.447122] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [321.541695] [077/133] (701s left) gem_exec_capture (capture) [321.601686] Starting subtest: capture [321.603705] Starting dynamic subtest: rcs0-smem [322.439743] Dynamic subtest rcs0-smem: SUCCESS (0.837s) [322.449241] Starting dynamic subtest: bcs0-smem [323.268035] Dynamic subtest bcs0-smem: SUCCESS (0.826s) [323.277662] Starting dynamic subtest: vcs0-smem [324.085100] Dynamic subtest vcs0-smem: SUCCESS (0.815s) [324.094681] Starting dynamic subtest: vcs1-smem [324.902633] Dynamic subtest vcs1-smem: SUCCESS (0.819s) [324.914372] Starting dynamic subtest: vecs0-smem [326.299540] Dynamic subtest vecs0-smem: FAIL (1.333s) [326.310382] Starting dynamic subtest: ccs0-smem [327.558963] Dynamic subtest ccs0-smem: SUCCESS (1.320s) [327.561874] Subtest capture: FAIL (5.956s) [327.695034] [078/133] (695s left) syncobj_basic (bad-pad-handle-to-fd) [327.749405] Starting subtest: bad-pad-handle-to-fd [327.751569] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [327.878199] [079/133] (695s left) i915_drm_fdinfo (memory-info-shared) [327.919584] Starting subtest: memory-info-shared [327.921969] Starting dynamic subtest: smem0 [327.956682] Dynamic subtest smem0: SUCCESS (0.037s) [327.959295] Subtest memory-info-shared: SUCCESS (0.038s) [328.031432] [080/133] (695s left) sw_sync (timeline_closed) [328.067204] Starting subtest: timeline_closed [328.069457] Subtest timeline_closed: SUCCESS (0.000s) [328.120341] [081/133] (695s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [328.213218] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [328.215430] Starting dynamic subtest: pipe-A-default-mode [330.913634] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s) [330.916146] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.703s) [331.772156] [082/133] (691s left) kms_psr (pr-primary-page-flip) [331.868089] Starting subtest: pr-primary-page-flip [331.872526] Subtest pr-primary-page-flip: SKIP (0.000s) [331.941494] [083/133] (691s left) kms_psr (fbc-pr-sprite-blt) [332.035645] Starting subtest: fbc-pr-sprite-blt [332.040529] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [332.116223] [084/133] (691s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [332.238421] Starting subtest: basic-flip-before-cursor-legacy [333.169744] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s) [334.015833] [085/133] (689s left) gem_ctx_param (invalid-ctx-set) [334.069598] Starting subtest: invalid-ctx-set [334.072055] Subtest invalid-ctx-set: SUCCESS (0.001s) [334.163450] [086/133] (689s left) syncobj_wait (invalid-wait-bad-flags) [334.224937] Starting subtest: invalid-wait-bad-flags [334.227684] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [334.336720] [087/133] (689s left) gem_exec_store (pages) [334.404422] Starting subtest: pages [334.406596] Starting dynamic subtest: rcs0 [334.512765] Dynamic subtest rcs0: SUCCESS (0.109s) [334.524936] Starting dynamic subtest: bcs0 [334.584517] Dynamic subtest bcs0: SUCCESS (0.072s) [334.595085] Starting dynamic subtest: vcs0 [334.646036] Dynamic subtest vcs0: SUCCESS (0.061s) [334.657145] Starting dynamic subtest: vcs1 [334.714497] Dynamic subtest vcs1: SUCCESS (0.068s) [334.725584] Starting dynamic subtest: vecs0 [334.789478] Dynamic subtest vecs0: SUCCESS (0.073s) [334.801627] Starting dynamic subtest: ccs0 [334.868144] Dynamic subtest ccs0: SUCCESS (0.078s) [334.870532] Subtest pages: SUCCESS (0.467s) [335.057833] [088/133] (688s left) gem_ctx_exec (basic-norecovery) [335.127564] Starting subtest: basic-norecovery [335.394683] Subtest basic-norecovery: SUCCESS (0.267s) [335.535193] [089/133] (688s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [335.592378] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [335.696428] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [335.783936] [090/133] (687s left) prime_mmap (test_errors) [335.841940] Starting subtest: test_errors [335.844655] Starting dynamic subtest: test_errors-smem [335.932211] Dynamic subtest test_errors-smem: SUCCESS (0.094s) [335.935667] Subtest test_errors: SUCCESS (0.095s) [336.055198] [091/133] (687s left) kms_vrr (negative-basic) [336.147381] Starting subtest: negative-basic [336.153636] Starting dynamic subtest: pipe-A-eDP-1 [341.570086] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s) [341.871973] Subtest negative-basic: SUCCESS (5.724s) [342.751681] [092/133] (680s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [342.863450] Starting subtest: cursorA-vs-flipA-atomic-transitions [354.029525] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.163s) [354.875325] [093/133] (668s left) dmabuf_sync_file (import-multiple-read-write) [354.927706] Starting subtest: import-multiple-read-write [354.929864] Subtest import-multiple-read-write: SUCCESS (0.003s) [354.985278] [094/133] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [355.079993] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [361.964471] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.887s) [362.090201] [095/133] (661s left) gem_exec_fence (syncobj-unused-fence) [362.532385] Starting subtest: syncobj-unused-fence [362.537108] Subtest syncobj-unused-fence: SUCCESS (0.006s) [364.366380] [096/133] (659s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [364.459405] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [364.461704] Starting dynamic subtest: pipe-A [364.481976] Dynamic subtest pipe-A: SKIP (0.019s) [364.492253] Starting dynamic subtest: pipe-B [364.515410] Dynamic subtest pipe-B: SKIP (0.033s) [364.525777] Starting dynamic subtest: pipe-C [364.548490] Dynamic subtest pipe-C: SKIP (0.032s) [364.558611] Starting dynamic subtest: pipe-D [364.578865] Dynamic subtest pipe-D: SKIP (0.032s) [364.582634] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.118s) [364.708081] [097/133] (659s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [364.774176] Starting subtest: mixed-tiled-to-yf-tiled-ccs [364.778827] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [364.957938] [098/133] (658s left) kms_big_fb (4-tiled-32bpp-rotate-0) [365.062448] Starting subtest: 4-tiled-32bpp-rotate-0 [366.475899] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.414s) [366.600690] [099/133] (657s left) kms_chamelium_edid (hdmi-mode-timings) [366.985184] Subtest hdmi-mode-timings: SKIP (0.000s) [367.822108] [100/133] (656s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [367.925555] Starting subtest: fbc-dirtyfb-ioctl [367.927545] Starting dynamic subtest: A-eDP-1 [370.513164] Dynamic subtest A-eDP-1: SUCCESS (2.586s) [370.515037] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.588s) [371.304376] [101/133] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [371.392695] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [371.396796] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [371.493470] [102/133] (652s left) i915_hangman (gt-engine-error) [371.555731] Starting subtest: gt-engine-error [371.557580] Starting dynamic subtest: rcs0 [373.283485] Dynamic subtest rcs0: SUCCESS (1.726s) [373.297407] Starting dynamic subtest: bcs0 [375.267694] Dynamic subtest bcs0: SUCCESS (1.981s) [375.282045] Starting dynamic subtest: vcs0 [377.251294] Dynamic subtest vcs0: SUCCESS (1.981s) [377.263382] Starting dynamic subtest: vcs1 [379.234345] Dynamic subtest vcs1: SUCCESS (1.980s) [379.248833] Starting dynamic subtest: vecs0 [381.283468] Dynamic subtest vecs0: SUCCESS (2.046s) [381.296787] Starting dynamic subtest: ccs0 [383.267242] Dynamic subtest ccs0: SUCCESS (1.980s) [383.270071] Subtest gt-engine-error: SUCCESS (11.712s) [383.361923] [103/133] (640s left) gem_exec_reloc (basic-write-cpu) [383.428804] Subtest basic-write-cpu: SKIP (0.000s) [383.507888] [104/133] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [383.607292] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [383.611139] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [383.700484] [105/133] (640s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [383.792485] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [383.796488] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [383.885189] [106/133] (640s left) gem_lmem_swapping (parallel-multi) [383.922931] Subtest parallel-multi: SKIP (0.000s) [383.970240] [107/133] (640s left) api_intel_allocator (two-level-inception-interruptible) [384.019211] Starting subtest: two-level-inception-interruptible [389.426177] Subtest two-level-inception-interruptible: SUCCESS (5.405s) [389.555172] [108/133] (634s left) prime_vgem (fence-wait) [389.652276] Starting subtest: fence-wait [389.654679] Starting dynamic subtest: rcs0 [390.702536] Dynamic subtest rcs0: SUCCESS (1.049s) [390.712945] Starting dynamic subtest: bcs0 [391.765204] Dynamic subtest bcs0: SUCCESS (1.062s) [391.776843] Starting dynamic subtest: vcs0 [392.807500] Dynamic subtest vcs0: SUCCESS (1.040s) [392.819529] Starting dynamic subtest: vcs1 [394.298898] Dynamic subtest vcs1: SUCCESS (1.489s) [394.311053] Starting dynamic subtest: vecs0 [395.339420] Dynamic subtest vecs0: SUCCESS (1.038s) [395.351538] Starting dynamic subtest: ccs0 [396.385046] Dynamic subtest ccs0: SUCCESS (1.043s) [396.388026] Subtest fence-wait: SUCCESS (6.733s) [396.526896] [109/133] (627s left) gem_mmap_wc (copy) [396.585756] Subtest copy: SKIP (0.000s) [396.644219] [110/133] (627s left) gem_exec_reloc (basic-range-active) [396.695652] Subtest basic-range-active: SKIP (0.000s) [396.778721] [111/133] (627s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [396.832614] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [396.839926] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [396.937668] [112/133] (627s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [397.472935] Starting subtest: syncobj-backward-timeline-chain-engines [397.665086] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.196s) [399.370790] [113/133] (625s left) i915_pm_rpm (reg-read-ioctl) [401.393686] Starting subtest: reg-read-ioctl [403.784438] Subtest reg-read-ioctl: SUCCESS (2.390s) [404.168952] [114/133] (620s left) gem_exec_balancer (bonded-false-hang) [404.440951] Starting subtest: bonded-false-hang [404.445999] Subtest bonded-false-hang: SKIP (0.000s) [404.568181] [115/133] (620s left) syncobj_wait (invalid-multi-wait-unsubmitted) [404.625063] Starting subtest: invalid-multi-wait-unsubmitted [404.627543] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [404.734860] [116/133] (619s left) gem_softpin (allocator-basic) [404.795533] Starting subtest: allocator-basic [404.864434] Subtest allocator-basic: SUCCESS (0.069s) [405.007601] [117/133] (619s left) kms_pm_rpm (fences) [406.523841] Starting subtest: fences [406.528425] Subtest fences: SKIP (0.000s) [407.296291] [118/133] (617s left) kms_cursor_crc (cursor-random-32x10) [407.458810] Starting subtest: cursor-random-32x10 [407.508438] Subtest cursor-random-32x10: SKIP (0.043s) [407.805471] [119/133] (617s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [407.903242] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [411.848752] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.950s) [412.970843] [120/133] (611s left) i915_selftest (live) [417.390488] Starting subtest: live [417.393455] Starting dynamic subtest: sanitycheck [421.724614] Dynamic subtest sanitycheck: SUCCESS (4.333s) [421.735062] Starting dynamic subtest: uncore [426.088344] Dynamic subtest uncore: SUCCESS (4.361s) [426.103948] Starting dynamic subtest: workarounds [429.271844] Dynamic subtest workarounds: SUCCESS (3.181s) [429.281895] Starting dynamic subtest: gt_engines [432.360457] Dynamic subtest gt_engines: SUCCESS (3.087s) [432.371157] Starting dynamic subtest: gt_timelines [447.938085] Dynamic subtest gt_timelines: SUCCESS (15.575s) [447.948882] Starting dynamic subtest: gt_contexts [452.330380] Dynamic subtest gt_contexts: SUCCESS (4.390s) [452.340756] Starting dynamic subtest: gt_lrc [456.683388] Dynamic subtest gt_lrc: SUCCESS (4.352s) [456.693114] Starting dynamic subtest: gt_mocs [459.725553] Dynamic subtest gt_mocs: SUCCESS (3.041s) [459.735836] Starting dynamic subtest: gt_pm [464.525336] Dynamic subtest gt_pm: SUCCESS (4.798s) [464.535470] Starting dynamic subtest: gt_heartbeat [468.866429] Dynamic subtest gt_heartbeat: SUCCESS (4.340s) [468.876788] Starting dynamic subtest: gt_tlb [478.166934] Dynamic subtest gt_tlb: SUCCESS (9.298s) [478.177715] Starting dynamic subtest: requests [491.704491] Dynamic subtest requests: SUCCESS (13.534s) [491.714676] Starting dynamic subtest: migrate [497.509712] Dynamic subtest migrate: SUCCESS (5.803s) [497.520396] Starting dynamic subtest: active [501.790050] Dynamic subtest active: SUCCESS (4.279s) [501.800471] Starting dynamic subtest: objects [506.520666] Dynamic subtest objects: SUCCESS (4.729s) [506.540488] Starting dynamic subtest: mman [511.335527] Dynamic subtest mman: SUCCESS (4.814s) [511.343840] Starting dynamic subtest: dmabuf [515.719036] Dynamic subtest dmabuf: SUCCESS (4.382s) [515.728324] Starting dynamic subtest: vma [520.085419] Dynamic subtest vma: SUCCESS (4.364s) [520.093304] Starting dynamic subtest: coherency [523.581261] Dynamic subtest coherency: SUCCESS (3.494s) [523.591306] Starting dynamic subtest: gtt [535.239529] Dynamic subtest gtt: SUCCESS (11.656s) [535.249635] Starting dynamic subtest: gem [543.039242] Dynamic subtest gem: SUCCESS (7.798s) [543.055531] Starting dynamic subtest: evict [548.570535] Dynamic subtest evict: SUCCESS (5.529s) [548.579340] Starting dynamic subtest: hugepages [559.421639] Dynamic subtest hugepages: SUCCESS (10.849s) [559.432254] Starting dynamic subtest: gem_contexts [587.901601] Dynamic subtest gem_contexts: SUCCESS (28.477s) [587.912226] Starting dynamic subtest: client [590.654998] Dynamic subtest client: SUCCESS (2.753s) [590.665635] Starting dynamic subtest: gem_migrate [595.006241] Dynamic subtest gem_migrate: SUCCESS (4.349s) [595.018306] Starting dynamic subtest: reset [597.797699] Dynamic subtest reset: SUCCESS (2.790s) [597.808553] Starting dynamic subtest: memory_region [602.112387] Dynamic subtest memory_region: SUCCESS (4.313s) [602.129976] Starting dynamic subtest: hangcheck [615.181898] Dynamic subtest hangcheck: SUCCESS (13.069s) [615.192204] Starting dynamic subtest: execlists [619.577316] Dynamic subtest execlists: SUCCESS (4.391s) [619.590416] Starting dynamic subtest: ring_submission [623.947999] Dynamic subtest ring_submission: SUCCESS (4.368s) [623.958796] Starting dynamic subtest: perf [628.325810] Dynamic subtest perf: SUCCESS (4.375s) [628.336212] Starting dynamic subtest: slpc [642.340945] Dynamic subtest slpc: SUCCESS (14.014s) [642.351549] Starting dynamic subtest: guc [646.252443] Dynamic subtest guc: SUCCESS (3.909s) [646.261664] Starting dynamic subtest: guc_multi_lrc [650.560909] Dynamic subtest guc_multi_lrc: SUCCESS (4.306s) [650.570884] Starting dynamic subtest: guc_hang [655.433980] Dynamic subtest guc_hang: SUCCESS (4.871s) [655.447927] Starting dynamic subtest: late_gt_pm [658.201036] Dynamic subtest late_gt_pm: SUCCESS (2.764s) [658.203980] Subtest live: SUCCESS (240.799s) [658.235324] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [658.236013] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [658.239385] [121/133] (366s left) kms_plane_cursor (primary) [659.801495] Starting subtest: primary [659.806251] Starting dynamic subtest: pipe-A-eDP-1-size-64 [662.429530] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.630s) [662.454093] Starting dynamic subtest: pipe-A-eDP-1-size-128 [665.031059] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s) [665.055304] Starting dynamic subtest: pipe-A-eDP-1-size-256 [667.687365] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.638s) [668.004661] Starting dynamic subtest: pipe-B-eDP-1-size-64 [671.329114] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.335s) [671.354227] Starting dynamic subtest: pipe-B-eDP-1-size-128 [673.908140] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s) [673.933495] Starting dynamic subtest: pipe-B-eDP-1-size-256 [676.498076] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s) [676.821988] Starting dynamic subtest: pipe-C-eDP-1-size-64 [679.726773] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.919s) [679.752641] Starting dynamic subtest: pipe-C-eDP-1-size-128 [681.959073] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [681.985860] Starting dynamic subtest: pipe-C-eDP-1-size-256 [684.192536] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s) [684.515652] Starting dynamic subtest: pipe-D-eDP-1-size-64 [687.444347] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.938s) [687.471591] Starting dynamic subtest: pipe-D-eDP-1-size-128 [689.667235] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s) [689.693533] Starting dynamic subtest: pipe-D-eDP-1-size-256 [691.933275] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.247s) [692.241172] Subtest primary: SUCCESS (32.440s) [693.111210] [FACT kms_plane_cursor (primary)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [693.113679] [FACT kms_plane_cursor (primary)] new: kernel.kmod_is_loaded.i915: true [693.118402] [122/133] (331s left) kms_flip (flip-vs-rmfb) [693.209402] Starting subtest: flip-vs-rmfb [693.211809] Starting dynamic subtest: A-eDP1 [701.850658] Dynamic subtest A-eDP1: SUCCESS (8.643s) [701.860969] Starting dynamic subtest: B-eDP1 [710.477937] Dynamic subtest B-eDP1: SUCCESS (8.626s) [710.488906] Starting dynamic subtest: C-eDP1 [719.105783] Dynamic subtest C-eDP1: SUCCESS (8.626s) [719.117220] Starting dynamic subtest: D-eDP1 [727.739180] Dynamic subtest D-eDP1: SUCCESS (8.632s) [727.743391] Subtest flip-vs-rmfb: SUCCESS (34.536s) [728.925863] [123/133] (296s left) drm_read (short-buffer-nonblock) [729.064194] Starting subtest: short-buffer-nonblock [729.066705] Subtest short-buffer-nonblock: SUCCESS (0.000s) [729.188850] [124/133] (295s left) gem_pxp (create-regular-context-1) [729.324578] Starting subtest: create-regular-context-1 [729.326876] Subtest create-regular-context-1: SUCCESS (0.001s) [729.428229] [125/133] (295s left) kms_chamelium_color (ctm-0-25) [729.519035] Subtest ctm-0-25: SKIP (0.000s) [729.565350] [126/133] (295s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [729.666093] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [729.670234] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [729.772381] [127/133] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [729.861396] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [736.977505] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.118s) [737.116806] [128/133] (288s left) syncobj_timeline (single-wait-for-submit-available-signaled) [737.165293] Starting subtest: single-wait-for-submit-available-signaled [737.167196] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [737.270505] [129/133] (287s left) gem_ccs (block-multicopy-inplace) [737.328704] Starting subtest: block-multicopy-inplace [737.333245] Subtest block-multicopy-inplace: SKIP (0.000s) [737.429803] [130/133] (287s left) gem_spin_batch (legacy-resubmit-new) [737.485113] Starting subtest: legacy-resubmit-new [737.487824] Starting dynamic subtest: default [737.490011] Dynamic subtest default: SUCCESS (0.007s) [737.500741] Starting dynamic subtest: render [737.503286] Dynamic subtest render: SUCCESS (0.002s) [737.512990] Starting dynamic subtest: bsd [737.515404] Dynamic subtest bsd: SUCCESS (0.004s) [737.525276] Starting dynamic subtest: bsd1 [737.527090] Dynamic subtest bsd1: SUCCESS (0.003s) [737.535733] Starting dynamic subtest: bsd2 [737.537616] Dynamic subtest bsd2: SUCCESS (0.004s) [737.546042] Starting dynamic subtest: blt [737.547963] Dynamic subtest blt: SUCCESS (0.004s) [737.556243] Starting dynamic subtest: vebox [737.558140] Dynamic subtest vebox: SUCCESS (0.003s) [737.560087] Subtest legacy-resubmit-new: SUCCESS (0.034s) [739.371971] [131/133] (285s left) kms_vblank (query-forked-hang) [739.458590] Starting subtest: query-forked-hang [739.460686] Starting dynamic subtest: pipe-A-eDP-1 [767.047644] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.586s) [767.062252] Starting dynamic subtest: pipe-D-eDP-1 [782.087108] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s) [782.089675] Subtest query-forked-hang: SUCCESS (42.629s) [782.923096] [132/133] (242s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [783.023790] Starting subtest: x-tiled-addfb-size-offset-overflow [783.026204] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [783.127688] [133/133] (242s left) kms_async_flips (async-flip-dpms) [783.214389] Starting subtest: async-flip-dpms [783.587383] Starting dynamic subtest: pipe-A-eDP-1 [787.450142] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.863s) [787.850847] Starting dynamic subtest: pipe-B-eDP-1 [790.727629] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.886s) [791.115907] Starting dynamic subtest: pipe-C-eDP-1 [793.896052] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.786s) [794.273824] Starting dynamic subtest: pipe-D-eDP-1 [797.058646] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.793s) [797.060837] Subtest async-flip-dpms: SUCCESS (13.845s) [798.240611] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: syncobj_wait results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_mmap_offset results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: kms_chamelium_hpd results: parsing output: 11/ for test: sw_sync results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_flip_scaled_crc results: parsing output: 15/ for test: gen9_exec_parse results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_draw_crc results: parsing output: 19/ for test: kms_content_protection results: parsing output: 20/ for test: kms_prop_blob results: parsing output: 21/ for test: syncobj_wait results: parsing output: 22/ for test: kms_pm_rpm results: parsing output: 23/ for test: kms_cursor_edge_walk results: parsing output: 24/ for test: gem_ctx_persistence results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_await results: parsing output: 27/ for test: gem_exec_schedule results: parsing output: 28/ for test: vgem_basic results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: gem_mmap_gtt results: parsing output: 32/ for test: gem_ctx_param results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_close_race results: parsing output: 36/ for test: gem_exec_nop results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_color results: parsing output: 42/ for test: gem_userptr_blits results: parsing output: 43/ for test: kms_joiner results: parsing output: 44/ for test: kms_cursor_crc results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_eio results: parsing output: 47/ for test: kms_plane results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_lease results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_getfb results: parsing output: 57/ for test: gem_exec_flush results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: api_intel_bb results: parsing output: 61/ for test: kms_psr2_sf results: parsing output: 62/ for test: kms_async_flips results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: gem_ctx_shared results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: gem_userptr_blits results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: gem_exec_params results: parsing output: 70/ for test: kms_universal_plane results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: kms_plane_scaling results: parsing output: 73/ for test: kms_plane_alpha_blend results: parsing output: 74/ for test: gem_lmem_swapping results: parsing output: 75/ for test: kms_setmode results: parsing output: 76/ for test: gem_exec_capture results: parsing output: 77/ for test: syncobj_basic results: parsing output: 78/ for test: i915_drm_fdinfo results: parsing output: 79/ for test: sw_sync results: parsing output: 80/ for test: kms_flip_scaled_crc results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_cursor_legacy results: parsing output: 84/ for test: gem_ctx_param results: parsing output: 85/ for test: syncobj_wait results: parsing output: 86/ for test: gem_exec_store results: parsing output: 87/ for test: gem_ctx_exec results: parsing output: 88/ for test: syncobj_wait results: parsing output: 89/ for test: prime_mmap results: parsing output: 90/ for test: kms_vrr results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: dmabuf_sync_file results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_exec_fence results: parsing output: 95/ for test: kms_plane_scaling results: parsing output: 96/ for test: gem_render_copy results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_chamelium_edid results: parsing output: 99/ for test: kms_dirtyfb results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: i915_hangman results: parsing output: 102/ for test: gem_exec_reloc results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: gem_lmem_swapping results: parsing output: 106/ for test: api_intel_allocator results: parsing output: 107/ for test: prime_vgem results: parsing output: 108/ for test: gem_mmap_wc results: parsing output: 109/ for test: gem_exec_reloc results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_exec_fence results: parsing output: 112/ for test: i915_pm_rpm results: parsing output: 113/ for test: gem_exec_balancer results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: gem_softpin results: parsing output: 116/ for test: kms_pm_rpm results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: i915_selftest results: parsing output: 120/ for test: kms_plane_cursor results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: drm_read results: parsing output: 123/ for test: gem_pxp results: parsing output: 124/ for test: kms_chamelium_color results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: gem_ccs results: parsing output: 129/ for test: gem_spin_batch results: parsing output: 130/ for test: kms_vblank results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_async_flips Done.