[58.490205] Initializing watchdogs [58.490253] /dev/watchdog0 [58.505835] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.510542] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.512842] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.514859] [001/133] (960s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [58.622926] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [58.634682] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [58.711466] [002/133] (960s left) kms_frontbuffer_tracking (basic) [58.802431] Starting subtest: basic [62.183621] Subtest basic: SUCCESS (3.360s) [62.336093] [003/133] (956s left) gem_userptr_blits (mmap-offset-banned) [62.402849] Starting subtest: mmap-offset-banned [62.403839] Starting dynamic subtest: wb [62.404776] Dynamic subtest wb: SUCCESS (0.000s) [62.412955] Starting dynamic subtest: wc [62.413856] Dynamic subtest wc: SUCCESS (0.000s) [62.419721] Starting dynamic subtest: uc [62.420599] Dynamic subtest uc: SUCCESS (0.000s) [62.421484] Subtest mmap-offset-banned: SUCCESS (0.003s) [62.519678] [004/133] (956s left) kms_prop_blob (invalid-set-prop) [62.573373] Starting subtest: invalid-set-prop [62.574341] Subtest invalid-set-prop: SUCCESS (0.000s) [62.681824] [005/133] (956s left) gem_exec_capture (capture) [62.754125] Starting subtest: capture [62.755157] Starting dynamic subtest: rcs0-smem [63.553517] Dynamic subtest rcs0-smem: SUCCESS (0.797s) [63.560039] Starting dynamic subtest: bcs0-smem [64.870372] Dynamic subtest bcs0-smem: SUCCESS (1.311s) [64.878876] Starting dynamic subtest: vcs0-smem [65.670877] Dynamic subtest vcs0-smem: SUCCESS (0.797s) [65.679897] Starting dynamic subtest: vcs1-smem [66.474322] Dynamic subtest vcs1-smem: SUCCESS (0.802s) [66.479805] Starting dynamic subtest: vecs0-smem [67.836407] Dynamic subtest vecs0-smem: FAIL (1.335s) [67.843149] Starting dynamic subtest: ccs0-smem [69.140742] Dynamic subtest ccs0-smem: SUCCESS (1.323s) [69.141663] Subtest capture: FAIL (6.367s) [69.235611] [006/133] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [69.325058] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [76.370881] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.039s) [76.463463] [007/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [76.563927] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [76.565691] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [76.655797] [008/133] (942s left) kms_addfb_basic (invalid-get-prop) [76.710143] Starting subtest: invalid-get-prop [76.711089] Subtest invalid-get-prop: SUCCESS (0.000s) [76.850222] [009/133] (942s left) kms_plane (pixel-format-linear-modifier) [76.944953] Starting subtest: pixel-format-linear-modifier [76.973782] Starting dynamic subtest: pipe-A-plane-0 [80.487131] Dynamic subtest pipe-A-plane-0: SUCCESS (3.511s) [80.494201] Starting dynamic subtest: pipe-A-plane-3 [82.132619] Dynamic subtest pipe-A-plane-3: SUCCESS (1.643s) [82.140638] Starting dynamic subtest: pipe-A-plane-5 [82.344051] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s) [83.417272] Starting dynamic subtest: pipe-B-plane-0 [86.856383] Dynamic subtest pipe-B-plane-0: SUCCESS (3.444s) [86.863360] Starting dynamic subtest: pipe-B-plane-3 [88.479692] Dynamic subtest pipe-B-plane-3: SUCCESS (1.622s) [88.486178] Starting dynamic subtest: pipe-B-plane-5 [88.679510] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s) [88.989409] Subtest pixel-format-linear-modifier: SUCCESS (12.037s) [89.794686] [010/133] (929s left) kms_flip (bo-too-big) [89.894931] Starting subtest: bo-too-big [89.897597] Starting dynamic subtest: A-eDP1 [91.248246] Dynamic subtest A-eDP1: SUCCESS (1.349s) [91.256727] Starting dynamic subtest: B-eDP1 [92.581418] Dynamic subtest B-eDP1: SUCCESS (1.332s) [92.589964] Starting dynamic subtest: C-eDP1 [93.914430] Dynamic subtest C-eDP1: SUCCESS (1.333s) [93.920578] Starting dynamic subtest: D-eDP1 [95.247455] Dynamic subtest D-eDP1: SUCCESS (1.330s) [95.248521] Subtest bo-too-big: SUCCESS (5.352s) [96.447094] [011/133] (922s left) gem_ctx_persistence (engines-queued) [96.503325] Starting subtest: engines-queued [96.504378] Starting dynamic subtest: rcs0 [96.591698] Dynamic subtest rcs0: SUCCESS (0.088s) [96.599227] Starting dynamic subtest: bcs0 [96.615960] Dynamic subtest bcs0: SUCCESS (0.024s) [96.622268] Starting dynamic subtest: vcs0 [97.853725] Dynamic subtest vcs0: SUCCESS (1.227s) [97.860775] Starting dynamic subtest: vcs1 [99.899948] Dynamic subtest vcs1: SUCCESS (2.044s) [99.906495] Starting dynamic subtest: vecs0 [101.883923] Dynamic subtest vecs0: SUCCESS (1.982s) [101.891303] Starting dynamic subtest: ccs0 [102.041044] Dynamic subtest ccs0: SUCCESS (0.165s) [102.042173] Subtest engines-queued: SUCCESS (5.536s) [102.147240] [012/133] (917s left) gem_exec_await (wide-all) [102.394246] Starting subtest: wide-all [125.741985] Subtest wide-all: SUCCESS (23.343s) [125.936318] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true [125.938533] [013/133] (893s left) kms_invalid_mode (bad-hsync-start) [126.079043] Starting subtest: bad-hsync-start [126.079969] Starting dynamic subtest: pipe-A-eDP-1 [126.376702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s) [126.392444] Starting dynamic subtest: pipe-B-eDP-1 [126.393507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [126.408469] Starting dynamic subtest: pipe-C-eDP-1 [126.409716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [126.418867] Starting dynamic subtest: pipe-D-eDP-1 [126.419928] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [126.420999] Subtest bad-hsync-start: SUCCESS (0.302s) [127.177266] [014/133] (892s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [127.295872] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [128.289610] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.994s) [129.106151] [015/133] (890s left) gem_pxp (verify-pxp-stale-buf-execution) [129.223373] Starting subtest: verify-pxp-stale-buf-execution [130.286210] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s) [130.414224] [016/133] (889s left) kms_psr (fbc-psr-cursor-render) [130.513480] Starting subtest: fbc-psr-cursor-render [130.514468] Starting dynamic subtest: eDP-1 [130.516133] Dynamic subtest eDP-1: SKIP (0.000s) [130.517802] Subtest fbc-psr-cursor-render: SKIP (0.001s) [130.578744] [017/133] (888s left) kms_cursor_crc (cursor-offscreen-128x128) [130.774753] Starting subtest: cursor-offscreen-128x128 [130.778277] Starting dynamic subtest: pipe-A-eDP-1 [132.712166] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [132.739988] Starting dynamic subtest: pipe-D-eDP-1 [135.318978] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s) [135.319916] Subtest cursor-offscreen-128x128: SUCCESS (4.543s) [136.176216] [018/133] (883s left) gem_ctx_persistence (legacy-engines-cleanup) [136.223205] Starting subtest: legacy-engines-cleanup [136.224139] Starting dynamic subtest: render [136.300517] Dynamic subtest render: SUCCESS (0.077s) [136.312517] Starting dynamic subtest: bsd1 [136.342256] Dynamic subtest bsd1: SUCCESS (0.039s) [136.351627] Starting dynamic subtest: bsd2 [136.380231] Dynamic subtest bsd2: SUCCESS (0.036s) [136.389489] Starting dynamic subtest: blt [136.411069] Dynamic subtest blt: SUCCESS (0.029s) [136.418801] Starting dynamic subtest: vebox [136.494759] Dynamic subtest vebox: SUCCESS (0.081s) [136.496062] Subtest legacy-engines-cleanup: SUCCESS (0.273s) [136.567051] [019/133] (883s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [136.672484] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [137.297818] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [137.472080] [020/133] (882s left) gen7_exec_parse (batch-without-end) [137.521620] Subtest batch-without-end: SKIP (0.000s) [137.578625] [021/133] (882s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [137.672481] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [137.673426] Starting dynamic subtest: pipe-A-default-mode [140.420117] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s) [140.421059] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.748s) [141.276555] [022/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [141.371043] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [148.424654] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.054s) [148.557692] [023/133] (871s left) kms_pm_dc (dc9-dpms) [149.654482] Starting subtest: dc9-dpms [151.082553] Subtest dc9-dpms: SUCCESS (1.428s) [151.151024] [024/133] (868s left) kms_legacy_colorkey (basic) [151.247207] Starting subtest: basic [151.248038] Starting dynamic subtest: pipe-A [151.292332] Dynamic subtest pipe-A: SUCCESS (0.045s) [151.304764] Starting dynamic subtest: pipe-B [151.305964] Dynamic subtest pipe-B: SUCCESS (0.001s) [151.312530] Starting dynamic subtest: pipe-C [151.313500] Dynamic subtest pipe-C: SUCCESS (0.001s) [151.320060] Starting dynamic subtest: pipe-D [151.320905] Dynamic subtest pipe-D: SUCCESS (0.001s) [151.321902] Subtest basic: SUCCESS (0.052s) [151.357048] [025/133] (868s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [151.456604] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [152.092961] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s) [152.251688] [026/133] (867s left) api_intel_bb (object-reloc-purge-cache) [152.306980] Starting subtest: object-reloc-purge-cache [152.310316] Subtest object-reloc-purge-cache: SKIP (0.004s) [152.420482] [027/133] (867s left) kms_atomic_interruptible (atomic-setmode) [152.518093] Starting subtest: atomic-setmode [152.518912] Starting dynamic subtest: pipe-A-eDP-1 [159.396569] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.878s) [159.397466] Subtest atomic-setmode: SUCCESS (6.879s) [160.189752] [028/133] (859s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [160.288212] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [160.289083] Starting dynamic subtest: pipe-A-eDP-1 [160.298528] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [160.305909] Starting dynamic subtest: pipe-B-eDP-1 [160.316044] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [160.322850] Starting dynamic subtest: pipe-C-eDP-1 [160.331644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [160.338131] Starting dynamic subtest: pipe-D-eDP-1 [160.347133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [160.348706] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [162.470154] [029/133] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [162.564050] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [162.565848] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [162.663635] [030/133] (857s left) gem_exec_whisper (basic-queues-priority) [162.725278] Starting subtest: basic-queues-priority [187.101906] Subtest basic-queues-priority: SUCCESS (24.329s) [187.238515] [031/133] (832s left) gem_exec_schedule (submit-late-slice) [187.301015] Starting subtest: submit-late-slice [187.301937] Starting dynamic subtest: rcs0 [187.358399] Dynamic subtest rcs0: SUCCESS (0.058s) [187.367432] Starting dynamic subtest: bcs0 [187.420349] Dynamic subtest bcs0: SUCCESS (0.060s) [187.430543] Starting dynamic subtest: vcs0 [187.468615] Dynamic subtest vcs0: SUCCESS (0.048s) [187.478360] Starting dynamic subtest: vcs1 [187.516816] Dynamic subtest vcs1: SUCCESS (0.048s) [187.526864] Starting dynamic subtest: vecs0 [187.563763] Dynamic subtest vecs0: SUCCESS (0.045s) [187.573544] Starting dynamic subtest: ccs0 [187.614502] Dynamic subtest ccs0: SUCCESS (0.050s) [187.615824] Subtest submit-late-slice: SUCCESS (0.314s) [188.960764] [032/133] (831s left) kms_force_connector_basic (force-edid) [189.041550] Starting subtest: force-edid [189.417548] Subtest force-edid: SUCCESS (0.377s) [189.557344] [033/133] (830s left) kms_selftest (drm_plane_helper) [189.599520] Starting subtest: drm_plane_helper [189.626816] Starting dynamic subtest: drm_test_check_plane_state [189.735408] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.108s) [189.743222] Starting dynamic subtest: drm_test_check_invalid_plane_state [189.838967] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.102s) [189.839934] Subtest drm_plane_helper: SUCCESS (0.239s) [189.979382] [034/133] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [190.070316] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [190.071814] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [190.165998] [035/133] (829s left) gem_media_vme [190.275085] [036/133] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [190.357574] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [190.359209] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [190.457394] [037/133] (829s left) gem_ctx_engines (invalid-engines) [190.510018] Starting subtest: invalid-engines [190.518082] Subtest invalid-engines: SUCCESS (0.008s) [190.760987] [038/133] (829s left) kms_big_fb (linear-64bpp-rotate-180) [190.844520] Starting subtest: linear-64bpp-rotate-180 [192.467205] Subtest linear-64bpp-rotate-180: SUCCESS (1.623s) [192.639332] [039/133] (827s left) perf (whitelisted-registers-userspace-config) [192.791159] Starting subtest: whitelisted-registers-userspace-config [192.791970] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [192.827201] [040/133] (827s left) gem_set_tiling_vs_blt (untiled-to-tiled) [192.882654] Subtest untiled-to-tiled: SKIP (0.000s) [192.947395] [041/133] (827s left) kms_vblank (wait-idle) [193.033248] Starting subtest: wait-idle [193.034200] Starting dynamic subtest: pipe-A-eDP-1 [194.801488] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s) [194.811167] Starting dynamic subtest: pipe-D-eDP-1 [197.200347] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.398s) [197.201304] Subtest wait-idle: SUCCESS (4.169s) [197.991527] [042/133] (822s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [198.086907] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [199.109183] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.022s) [199.218970] [043/133] (821s left) sysfs_preempt_timeout (idempotent) [199.272381] Starting subtest: idempotent [199.273360] Starting dynamic subtest: vecs0 [199.274250] Dynamic subtest vecs0: SUCCESS (0.000s) [199.281931] Starting dynamic subtest: ccs0 [199.282738] Dynamic subtest ccs0: SUCCESS (0.000s) [199.289925] Starting dynamic subtest: vcs0 [199.290786] Dynamic subtest vcs0: SUCCESS (0.000s) [199.298328] Starting dynamic subtest: bcs0 [199.299117] Dynamic subtest bcs0: SUCCESS (0.000s) [199.306267] Starting dynamic subtest: rcs0 [199.307065] Dynamic subtest rcs0: SUCCESS (0.000s) [199.314204] Starting dynamic subtest: vcs1 [199.315058] Dynamic subtest vcs1: SUCCESS (0.000s) [199.315904] Subtest idempotent: SUCCESS (0.006s) [199.348732] [044/133] (821s left) kms_cursor_crc (cursor-random-64x64) [199.517448] Starting subtest: cursor-random-64x64 [199.520845] Starting dynamic subtest: pipe-A-eDP-1 [202.908439] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.388s) [202.939795] Starting dynamic subtest: pipe-D-eDP-1 [206.858579] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.925s) [206.859601] Subtest cursor-random-64x64: SUCCESS (7.341s) [207.699988] [045/133] (812s left) kms_frontbuffer_tracking (fbc-tiling-y) [207.794625] Starting subtest: fbc-tiling-y [207.796597] Subtest fbc-tiling-y: SKIP (0.000s) [207.878164] [046/133] (812s left) gem_exec_balancer (invalid-bonds) [207.934693] Starting subtest: invalid-bonds [207.937053] Subtest invalid-bonds: SKIP (0.000s) [208.249047] [047/133] (812s left) kms_frontbuffer_tracking (psr-suspend) [208.339124] Starting subtest: psr-suspend [246.336347] Subtest psr-suspend: SUCCESS (8.758s) [253.482628] [048/133] (774s left) core_getversion (basic) [253.521959] Starting subtest: basic [253.524473] Subtest basic: SUCCESS (0.000s) [253.605709] [049/133] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [253.701193] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [253.703184] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [253.807438] [050/133] (773s left) gem_softpin (noreloc-interruptible) [253.865917] Starting subtest: noreloc-interruptible [259.420770] Subtest noreloc-interruptible: SUCCESS (5.399s) [259.520267] [051/133] (768s left) vgem_basic (sysfs) [259.559582] Starting subtest: sysfs [259.560776] Subtest sysfs: SUCCESS (0.000s) [259.614838] [052/133] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [259.700105] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [259.702151] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [259.824898] [053/133] (767s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [259.882295] Starting subtest: multi-wait-for-submit-available-signaled [259.883369] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [259.987686] [054/133] (767s left) kms_psr (psr2-cursor-plane-onoff) [260.070745] Starting subtest: psr2-cursor-plane-onoff [260.071639] Starting dynamic subtest: eDP-1 [261.756291] Dynamic subtest eDP-1: SUCCESS (1.666s) [261.757150] Subtest psr2-cursor-plane-onoff: SUCCESS (1.667s) [262.621864] [055/133] (765s left) gem_exec_gttfill (multigpu-basic) [262.804204] Starting subtest: multigpu-basic [275.270636] Subtest multigpu-basic: SUCCESS (12.410s) [275.341314] [056/133] (752s left) kms_setmode (invalid-clone-single-crtc) [275.420139] Starting subtest: invalid-clone-single-crtc [275.422696] Subtest invalid-clone-single-crtc: SKIP (0.000s) [275.513997] [057/133] (752s left) kms_busy (basic-hang) [275.613605] Starting subtest: basic-hang [275.614618] Starting dynamic subtest: flip-pipe-A [276.236488] Dynamic subtest flip-pipe-A: SUCCESS (0.621s) [276.245476] Starting dynamic subtest: modeset-pipe-A [279.926926] Dynamic subtest modeset-pipe-A: SUCCESS (3.684s) [279.949981] Starting dynamic subtest: flip-pipe-D [281.178410] Dynamic subtest flip-pipe-D: SUCCESS (1.248s) [281.186775] Starting dynamic subtest: modeset-pipe-D [284.528791] Dynamic subtest modeset-pipe-D: SUCCESS (3.348s) [284.529711] Subtest basic-hang: SUCCESS (8.909s) [285.387841] [058/133] (742s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [285.483671] Starting subtest: fbc-farfromfence-mmap-gtt [285.485361] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [285.574361] [059/133] (742s left) perf_pmu (most-busy-check-all) [285.606723] Starting subtest: most-busy-check-all [285.607687] Starting dynamic subtest: rcs0 [287.125345] Dynamic subtest rcs0: SUCCESS (1.508s) [287.136720] Starting dynamic subtest: bcs0 [289.174114] Dynamic subtest bcs0: SUCCESS (2.045s) [289.187174] Starting dynamic subtest: vcs0 [291.160199] Dynamic subtest vcs0: SUCCESS (1.982s) [291.171846] Starting dynamic subtest: vcs1 [293.137998] Dynamic subtest vcs1: SUCCESS (1.977s) [293.149190] Starting dynamic subtest: vecs0 [295.125462] Dynamic subtest vecs0: SUCCESS (1.980s) [295.136225] Starting dynamic subtest: ccs0 [297.173868] Dynamic subtest ccs0: SUCCESS (2.045s) [297.175632] Subtest most-busy-check-all: SUCCESS (11.555s) [297.268960] [060/133] (730s left) kms_psr (psr-dpms) [297.372570] Starting subtest: psr-dpms [297.373774] Starting dynamic subtest: eDP-1 [300.283999] Dynamic subtest eDP-1: SUCCESS (2.910s) [300.284875] Subtest psr-dpms: SUCCESS (2.911s) [301.096869] [061/133] (727s left) kms_cursor_edge_walk (128x128-left-edge) [301.178293] Starting subtest: 128x128-left-edge [301.179180] Starting dynamic subtest: pipe-A-eDP-1 [304.638215] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s) [304.646771] Starting dynamic subtest: pipe-D-eDP-1 [307.827429] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.186s) [307.828266] Subtest 128x128-left-edge: SUCCESS (6.647s) [308.702142] [062/133] (719s left) gem_exec_schedule (pi-ringfull) [308.900196] Starting subtest: pi-ringfull [308.901296] Starting dynamic subtest: rcs0 [308.932124] Dynamic subtest rcs0: SUCCESS (0.037s) [308.943438] Starting dynamic subtest: bcs0 [308.974142] Dynamic subtest bcs0: SUCCESS (0.041s) [308.983364] Starting dynamic subtest: vcs0 [309.007013] Dynamic subtest vcs0: SUCCESS (0.032s) [309.015196] Starting dynamic subtest: vcs1 [309.036796] Dynamic subtest vcs1: SUCCESS (0.029s) [309.050650] Starting dynamic subtest: vecs0 [309.068295] Dynamic subtest vecs0: SUCCESS (0.030s) [309.080638] Starting dynamic subtest: ccs0 [309.095542] Dynamic subtest ccs0: SUCCESS (0.026s) [309.096522] Subtest pi-ringfull: SUCCESS (0.202s) [309.310783] [063/133] (718s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [309.410860] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [309.411856] Starting dynamic subtest: pipe-A-eDP-1 [309.419967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [309.430501] Starting dynamic subtest: pipe-B-eDP-1 [309.438219] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [309.446426] Starting dynamic subtest: pipe-C-eDP-1 [309.453891] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [309.461822] Starting dynamic subtest: pipe-D-eDP-1 [309.469108] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [309.469934] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [311.708730] [064/133] (716s left) kms_psr (fbc-pr-sprite-mmap-gtt) [311.791798] Starting subtest: fbc-pr-sprite-mmap-gtt [311.793597] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [311.872753] [065/133] (716s left) gem_render_copy_redux (flink-interruptible) [311.932484] Starting subtest: flink-interruptible [312.642032] Subtest flink-interruptible: SUCCESS (0.710s) [312.771963] [066/133] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [312.865613] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [312.867278] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [312.958330] [067/133] (715s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [313.048591] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [313.049567] Starting dynamic subtest: pipe-A-eDP-1 [313.939655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.889s) [313.948254] Starting dynamic subtest: pipe-B-eDP-1 [315.588017] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.646s) [315.596642] Starting dynamic subtest: pipe-C-eDP-1 [317.081023] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s) [317.089871] Starting dynamic subtest: pipe-D-eDP-1 [318.575764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.493s) [318.576620] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.524s) [319.828994] [068/133] (708s left) kms_draw_crc (draw-method-mmap-cpu) [319.922816] Starting subtest: draw-method-mmap-cpu [319.923734] Starting dynamic subtest: xrgb8888-untiled [320.166811] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [320.176939] Starting dynamic subtest: rgb565-untiled [320.400134] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [320.408816] Starting dynamic subtest: xrgb2101010-untiled [320.622452] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [320.631255] Starting dynamic subtest: xbgr16161616f-untiled [320.844763] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [320.853221] Starting dynamic subtest: xrgb8888-xtiled [320.977979] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [320.986453] Starting dynamic subtest: rgb565-xtiled [321.111454] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [321.120204] Starting dynamic subtest: xrgb2101010-xtiled [321.233851] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [321.243357] Starting dynamic subtest: xbgr16161616f-xtiled [321.367309] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s) [321.375944] Starting dynamic subtest: xrgb8888-4tiled [321.522758] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [321.531090] Starting dynamic subtest: rgb565-4tiled [321.656242] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s) [321.664356] Starting dynamic subtest: xrgb2101010-4tiled [321.789505] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [321.798258] Starting dynamic subtest: xbgr16161616f-4tiled [321.933973] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [321.934921] Subtest draw-method-mmap-cpu: SUCCESS (2.011s) [322.029545] [069/133] (706s left) kms_plane_cursor (overlay) [322.117496] Starting subtest: overlay [322.119271] Starting dynamic subtest: pipe-A-eDP-1-size-64 [324.657766] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.540s) [324.717953] Starting dynamic subtest: pipe-A-eDP-1-size-128 [327.315769] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.605s) [327.378886] Starting dynamic subtest: pipe-A-eDP-1-size-256 [329.895732] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s) [330.245750] Starting dynamic subtest: pipe-B-eDP-1-size-64 [333.525739] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.287s) [333.588090] Starting dynamic subtest: pipe-B-eDP-1-size-128 [336.183603] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s) [336.245778] Starting dynamic subtest: pipe-B-eDP-1-size-256 [338.751858] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.515s) [339.115129] Starting dynamic subtest: pipe-C-eDP-1-size-64 [342.165491] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.058s) [342.204037] Starting dynamic subtest: pipe-C-eDP-1-size-128 [344.409974] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [344.452428] Starting dynamic subtest: pipe-C-eDP-1-size-256 [346.608046] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s) [346.936200] Starting dynamic subtest: pipe-D-eDP-1-size-64 [349.848492] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.921s) [349.889609] Starting dynamic subtest: pipe-D-eDP-1-size-128 [352.103886] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s) [352.142238] Starting dynamic subtest: pipe-D-eDP-1-size-256 [354.347407] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s) [354.669567] Subtest overlay: SUCCESS (32.548s) [355.519476] [070/133] (672s left) kms_getfb (getfb-handle-valid) [355.602745] Starting subtest: getfb-handle-valid [355.603744] Subtest getfb-handle-valid: SUCCESS (0.000s) [355.699501] [071/133] (672s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [355.786601] Starting subtest: plane-scaler-unity-scaling-with-modifiers [355.787400] Starting dynamic subtest: pipe-A [356.125369] Dynamic subtest pipe-A: SUCCESS (0.339s) [356.135186] Starting dynamic subtest: pipe-B [357.580493] Dynamic subtest pipe-B: SUCCESS (1.454s) [357.589143] Starting dynamic subtest: pipe-C [358.972375] Dynamic subtest pipe-C: SUCCESS (1.391s) [358.982140] Starting dynamic subtest: pipe-D [360.375657] Dynamic subtest pipe-D: SUCCESS (1.402s) [360.376506] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.591s) [361.511380] [072/133] (667s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [361.570944] Starting subtest: stress-mm-invalidate-close-overlap [363.764221] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [363.829231] [073/133] (664s left) kms_big_fb (y-tiled-addfb) [363.923943] Starting subtest: y-tiled-addfb [363.925678] Subtest y-tiled-addfb: SKIP (0.000s) [364.016707] [074/133] (664s left) vgem_basic (dmabuf-fence-before) [364.064585] Starting subtest: dmabuf-fence-before [364.065440] Subtest dmabuf-fence-before: SUCCESS (0.001s) [364.118158] [075/133] (664s left) i915_getparams_basic (basic-eu-total) [364.160361] Starting subtest: basic-eu-total [364.162110] Subtest basic-eu-total: SUCCESS (0.000s) [364.228807] [076/133] (664s left) i915_drm_fdinfo (all-busy-check-all) [364.269841] Starting subtest: all-busy-check-all [364.273019] Subtest all-busy-check-all: SKIP (0.004s) [364.337921] [077/133] (664s left) kms_content_protection (atomic) [364.497008] Starting subtest: atomic [364.498735] Subtest atomic: SKIP (0.000s) [364.605304] [078/133] (664s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [364.695610] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [364.697262] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [364.785071] [079/133] (663s left) kms_pm_rpm (modeset-non-lpsp-stress) [366.322081] Starting subtest: modeset-non-lpsp-stress [367.480984] Subtest modeset-non-lpsp-stress: SKIP (1.159s) [367.858930] [080/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [367.945822] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [367.947507] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [368.040490] [081/133] (660s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [368.122455] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [368.123458] Starting dynamic subtest: pipe-A [368.143226] Dynamic subtest pipe-A: SKIP (0.018s) [368.151949] Starting dynamic subtest: pipe-B [368.176230] Dynamic subtest pipe-B: SKIP (0.032s) [368.184860] Starting dynamic subtest: pipe-C [368.209647] Dynamic subtest pipe-C: SKIP (0.033s) [368.217785] Starting dynamic subtest: pipe-D [368.242239] Dynamic subtest pipe-D: SKIP (0.033s) [368.243995] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.119s) [368.332333] [082/133] (660s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [368.426290] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [368.427848] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [368.494780] [083/133] (660s left) gem_exec_reloc (basic-wc-cpu-active) [368.547880] Subtest basic-wc-cpu-active: SKIP (0.000s) [368.607708] [084/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [368.694334] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [368.696289] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [368.793675] [085/133] (660s left) i915_pm_rps (min-max-config-loaded) [368.858157] Starting subtest: min-max-config-loaded [368.860209] Subtest min-max-config-loaded: SKIP (0.001s) [368.947624] [086/133] (660s left) prime_vgem (sync) [369.016960] Starting subtest: sync [369.017821] Starting dynamic subtest: rcs0 [369.072164] Dynamic subtest rcs0: SUCCESS (0.055s) [369.080239] Starting dynamic subtest: bcs0 [369.143659] Dynamic subtest bcs0: SUCCESS (0.070s) [369.151502] Starting dynamic subtest: vcs0 [369.191248] Dynamic subtest vcs0: SUCCESS (0.047s) [369.199621] Starting dynamic subtest: vcs1 [369.237384] Dynamic subtest vcs1: SUCCESS (0.045s) [369.245569] Starting dynamic subtest: vecs0 [369.283141] Dynamic subtest vecs0: SUCCESS (0.045s) [369.291464] Starting dynamic subtest: ccs0 [369.331195] Dynamic subtest ccs0: SUCCESS (0.047s) [369.333815] Subtest sync: SUCCESS (0.316s) [369.462280] [087/133] (659s left) gem_exec_whisper (basic-normal) [369.517858] Starting subtest: basic-normal [373.470981] Subtest basic-normal: SUCCESS (3.945s) [373.643446] [088/133] (655s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [373.701957] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [373.703928] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [373.899973] [089/133] (655s left) kms_properties (get_properties-sanity-non-atomic) [373.997643] Starting subtest: get_properties-sanity-non-atomic [373.998497] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [374.068930] [090/133] (655s left) i915_suspend (fence-restore-tiled2untiled) [374.120789] Starting subtest: fence-restore-tiled2untiled [374.122537] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [374.227987] [091/133] (654s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [374.616928] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [375.388650] [092/133] (653s left) kms_addfb_basic (bad-pitch-128) [375.432450] Starting subtest: bad-pitch-128 [375.433354] Subtest bad-pitch-128: SUCCESS (0.000s) [375.564094] [093/133] (653s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [375.616351] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [375.720998] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [375.804859] [094/133] (653s left) gem_userptr_blits (invalid-null-pointer) [375.865823] Starting subtest: invalid-null-pointer [375.866683] Subtest invalid-null-pointer: SUCCESS (0.001s) [375.995942] [095/133] (653s left) gem_mmap_gtt (pf-nonblock) [376.057999] Subtest pf-nonblock: SKIP (0.000s) [376.115754] [096/133] (653s left) kms_atomic (atomic-invalid-params) [376.199858] Starting subtest: atomic-invalid-params [376.200838] Starting dynamic subtest: pipe-A-eDP-1 [376.592473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s) [376.593440] Subtest atomic-invalid-params: SUCCESS (0.394s) [377.393056] [097/133] (651s left) kms_psr (pr-cursor-render) [377.474795] Starting subtest: pr-cursor-render [377.476497] Subtest pr-cursor-render: SKIP (0.000s) [377.548919] [098/133] (651s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [377.605275] Starting subtest: invalid-multi-wait-unsubmitted-submitted [377.606274] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [377.708550] [099/133] (651s left) kms_color (legacy-gamma) [377.804710] Starting subtest: legacy-gamma [377.805514] Starting dynamic subtest: pipe-A-eDP-1 [378.525940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s) [378.534459] Starting dynamic subtest: pipe-B-eDP-1 [380.012585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [380.021139] Starting dynamic subtest: pipe-C-eDP-1 [381.317832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s) [381.326131] Starting dynamic subtest: pipe-D-eDP-1 [382.710279] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s) [382.711408] Subtest legacy-gamma: SUCCESS (4.905s) [383.503084] [100/133] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [383.594200] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [391.060456] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.466s) [391.168743] [101/133] (638s left) gem_mmap (short-mmap) [391.229593] Subtest short-mmap: SKIP (0.000s) [391.280153] [102/133] (638s left) gem_workarounds (basic-read-fd) [391.346576] Starting subtest: basic-read-fd [391.364915] Subtest basic-read-fd: SUCCESS (0.018s) [391.467460] [103/133] (638s left) syncobj_timeline (invalid-transfer-illegal-handle) [391.513748] Starting subtest: invalid-transfer-illegal-handle [391.514696] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [391.602833] [104/133] (638s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [391.690696] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [391.702204] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [391.793316] [105/133] (637s left) kms_cursor_legacy (torture-move) [391.903042] Starting subtest: torture-move [391.903887] Starting dynamic subtest: pipe-A [398.212911] Dynamic subtest pipe-A: SUCCESS (6.261s) [398.223353] Starting dynamic subtest: pipe-B [405.280456] Dynamic subtest pipe-B: SUCCESS (7.099s) [405.295225] Starting dynamic subtest: pipe-C [411.879759] Dynamic subtest pipe-C: SUCCESS (6.605s) [411.892964] Starting dynamic subtest: pipe-D [419.684948] Dynamic subtest pipe-D: SUCCESS (7.796s) [419.693224] Starting dynamic subtest: all-pipes [426.182567] Dynamic subtest all-pipes: SUCCESS (6.500s) [426.183507] Subtest torture-move: SUCCESS (34.272s) [426.336484] [106/133] (603s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [426.436777] Starting subtest: basic-modeset-with-all-modifiers-formats [426.823154] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [427.571672] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.748s) [427.582280] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [427.593661] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s) [427.602165] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [427.616121] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s) [427.627052] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [427.771543] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s) [427.780089] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [427.793856] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s) [427.802267] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [427.816107] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s) [427.824381] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [427.838330] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s) [427.847220] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [427.868255] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s) [427.876720] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [427.882724] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s) [427.890331] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [427.904986] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s) [427.912689] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [427.927337] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s) [427.935289] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [427.949346] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s) [427.957372] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [428.105100] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s) [428.118195] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [428.127323] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s) [428.135370] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [428.149474] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s) [428.157452] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [428.171972] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s) [428.179939] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [428.194102] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s) [428.202172] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [428.216229] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s) [428.224323] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [428.238432] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s) [428.246379] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [428.260659] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s) [428.268769] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [428.282928] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s) [428.291300] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [428.438921] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s) [428.447439] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [428.461173] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s) [428.469468] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [428.483331] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s) [428.491562] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [428.505495] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s) [428.513767] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [428.527891] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s) [428.536444] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [428.550131] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [428.560132] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [428.572307] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s) [428.580468] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [428.594379] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s) [428.602626] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [428.616692] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s) [429.009828] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.573s) [429.801570] [107/133] (599s left) gem_barrier_race (remote-request) [429.858678] Starting subtest: remote-request [429.859728] Starting dynamic subtest: rcs0 [435.009438] Dynamic subtest rcs0: SUCCESS (5.149s) [435.014555] Subtest remote-request: SUCCESS (5.150s) [435.146153] [108/133] (594s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [435.243848] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [435.245465] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [435.363369] [109/133] (594s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [435.416735] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [435.521464] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [435.592711] [110/133] (594s left) kms_chamelium_audio (hdmi-audio) [435.978707] Subtest hdmi-audio: SKIP (0.000s) [436.778747] [111/133] (593s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [436.881191] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [436.882955] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [436.961900] [112/133] (592s left) prime_mmap (test_correct_cpu_write) [437.011180] Starting subtest: test_correct_cpu_write [437.012488] Starting dynamic subtest: test_correct_cpu_write-smem [437.013448] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [437.014384] Subtest test_correct_cpu_write: SUCCESS (0.001s) [437.106198] [113/133] (592s left) perf (global-sseu-config) [437.204497] Starting subtest: global-sseu-config [437.206637] Subtest global-sseu-config: SKIP (0.000s) [437.243878] [114/133] (592s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [437.332938] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [437.335582] Starting dynamic subtest: A-eDP1 [440.953448] Dynamic subtest A-eDP1: SUCCESS (3.616s) [440.963717] Starting dynamic subtest: B-eDP1 [444.241741] Dynamic subtest B-eDP1: SUCCESS (3.285s) [444.250286] Starting dynamic subtest: C-eDP1 [447.548259] Dynamic subtest C-eDP1: SUCCESS (3.304s) [447.556752] Starting dynamic subtest: D-eDP1 [450.849861] Dynamic subtest D-eDP1: SUCCESS (3.300s) [450.852778] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.514s) [451.726801] [115/133] (578s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [451.816844] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [451.817651] Starting dynamic subtest: pipe-A-eDP-1 [451.833890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [451.843501] Starting dynamic subtest: pipe-B-eDP-1 [451.852880] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [451.866048] Starting dynamic subtest: pipe-C-eDP-1 [451.873651] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [451.881932] Starting dynamic subtest: pipe-D-eDP-1 [451.893011] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [451.895220] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [454.106272] [116/133] (575s left) gem_pwrite (basic-random) [454.161440] Subtest basic-random: SKIP (0.000s) [454.220770] [117/133] (575s left) kms_flip (2x-flip-vs-panning-vs-hang) [454.319963] Starting subtest: 2x-flip-vs-panning-vs-hang [454.330044] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [454.444651] [118/133] (575s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [454.563718] Starting subtest: cursorA-vs-flipB-toggle [454.565354] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [454.703227] [119/133] (575s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [454.791622] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [454.793305] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [454.871686] [120/133] (575s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [455.262967] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [456.081918] [121/133] (574s left) kms_flip (dpms-off-confusion-interruptible) [456.175794] Starting subtest: dpms-off-confusion-interruptible [456.178085] Starting dynamic subtest: A-eDP1 [464.917228] Dynamic subtest A-eDP1: SUCCESS (8.710s) [464.926273] Starting dynamic subtest: B-eDP1 [473.610256] Dynamic subtest B-eDP1: SUCCESS (8.690s) [473.619699] Starting dynamic subtest: C-eDP1 [482.327150] Dynamic subtest C-eDP1: SUCCESS (8.704s) [482.343326] Starting dynamic subtest: D-eDP1 [491.013710] Dynamic subtest D-eDP1: SUCCESS (8.687s) [491.014943] Subtest dpms-off-confusion-interruptible: SUCCESS (34.805s) [492.212598] [122/133] (538s left) syncobj_timeline (single-wait-for-submit-available-signaled) [492.261739] Starting subtest: single-wait-for-submit-available-signaled [492.262755] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [492.376258] [123/133] (537s left) kms_psr (fbc-pr-dpms) [492.465754] Starting subtest: fbc-pr-dpms [492.467336] Subtest fbc-pr-dpms: SKIP (0.000s) [492.551460] [124/133] (537s left) kms_flip (blocking-wf_vblank) [492.641863] Starting subtest: blocking-wf_vblank [492.644528] Starting dynamic subtest: A-eDP1 [501.553758] Dynamic subtest A-eDP1: SUCCESS (8.886s) [501.562106] Starting dynamic subtest: B-eDP1 [510.442340] Dynamic subtest B-eDP1: SUCCESS (8.887s) [510.455450] Starting dynamic subtest: C-eDP1 [519.346828] Dynamic subtest C-eDP1: SUCCESS (8.891s) [519.357618] Starting dynamic subtest: D-eDP1 [528.239438] Dynamic subtest D-eDP1: SUCCESS (8.890s) [528.240451] Subtest blocking-wf_vblank: SUCCESS (35.569s) [529.396715] [125/133] (500s left) kms_plane_alpha_blend (alpha-7efc) [529.497370] Starting subtest: alpha-7efc [529.821625] Starting dynamic subtest: pipe-A-eDP-1 [530.475935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s) [530.534442] Starting dynamic subtest: pipe-D-eDP-1 [531.795764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s) [531.796746] Subtest alpha-7efc: SUCCESS (2.297s) [532.593602] [126/133] (497s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [532.683135] Starting subtest: flip-vs-dpms-on-nop-interruptible [532.685407] Starting dynamic subtest: A-eDP1 [534.575166] Dynamic subtest A-eDP1: SUCCESS (1.889s) [534.587148] Starting dynamic subtest: B-eDP1 [536.456446] Dynamic subtest B-eDP1: SUCCESS (1.878s) [536.476573] Starting dynamic subtest: C-eDP1 [538.244173] Dynamic subtest C-eDP1: SUCCESS (1.785s) [538.255584] Starting dynamic subtest: D-eDP1 [540.051709] Dynamic subtest D-eDP1: SUCCESS (1.807s) [540.055460] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.372s) [541.207810] [127/133] (489s left) api_intel_allocator (simple-allocator) [541.263428] Starting subtest: simple-allocator [541.264363] Starting dynamic subtest: basic [541.265924] Dynamic subtest basic: SUCCESS (0.004s) [541.276762] Starting dynamic subtest: parallel-one [541.462623] Dynamic subtest parallel-one: SUCCESS (0.186s) [541.471822] Starting dynamic subtest: print [541.472752] Dynamic subtest print: SUCCESS (0.000s) [541.481014] Starting dynamic subtest: reuse [541.482176] Dynamic subtest reuse: SUCCESS (0.000s) [541.491603] Starting dynamic subtest: reserve [541.492473] Dynamic subtest reserve: SUCCESS (0.000s) [541.500383] Starting dynamic subtest: fork-reopen-allocator [541.501263] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [541.502136] Subtest simple-allocator: SUCCESS (0.205s) [541.610654] [128/133] (488s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [541.737468] Starting subtest: short-flip-after-cursor-toggle [542.655970] Subtest short-flip-after-cursor-toggle: SUCCESS (0.917s) [543.512221] [129/133] (487s left) gem_ctx_shared (q-in-order) [543.570738] Starting subtest: Q-in-order [543.571686] Starting dynamic subtest: rcs0 [543.678228] Dynamic subtest rcs0: SUCCESS (0.107s) [543.694965] Starting dynamic subtest: vcs0 [543.768511] Dynamic subtest vcs0: SUCCESS (0.089s) [543.785421] Starting dynamic subtest: vcs1 [543.846103] Dynamic subtest vcs1: SUCCESS (0.076s) [543.862917] Starting dynamic subtest: vecs0 [543.922662] Dynamic subtest vecs0: SUCCESS (0.076s) [543.939012] Starting dynamic subtest: ccs0 [544.006894] Dynamic subtest ccs0: SUCCESS (0.083s) [544.008373] Subtest Q-in-order: SUCCESS (0.437s) [545.253007] [130/133] (485s left) gem_exec_fence (syncobj-timeline-invalid-wait) [545.788230] Starting subtest: syncobj-timeline-invalid-wait [545.789409] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [547.224758] [131/133] (483s left) i915_query (query-topology-unsupported) [547.290913] Starting subtest: query-topology-unsupported [547.292958] Subtest query-topology-unsupported: SKIP (0.000s) [547.391358] [132/133] (483s left) gem_softpin (reverse) [547.456611] Starting subtest: reverse [547.464839] Subtest reverse: SUCCESS (0.009s) [547.609120] [133/133] (483s left) gem_readwrite (write-bad-handle) [547.676883] Subtest write-bad-handle: SKIP (0.000s) [547.733151] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_userptr_blits results: parsing output: 3/ for test: kms_prop_blob results: parsing output: 4/ for test: gem_exec_capture results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_addfb_basic results: parsing output: 8/ for test: kms_plane results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: gem_ctx_persistence results: parsing output: 11/ for test: gem_exec_await results: parsing output: 12/ for test: kms_invalid_mode results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: gem_pxp results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_cursor_crc results: parsing output: 17/ for test: gem_ctx_persistence results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gen7_exec_parse results: parsing output: 20/ for test: kms_flip_scaled_crc results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_pm_dc results: parsing output: 23/ for test: kms_legacy_colorkey results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: api_intel_bb results: parsing output: 26/ for test: kms_atomic_interruptible results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_whisper results: parsing output: 30/ for test: gem_exec_schedule results: parsing output: 31/ for test: kms_force_connector_basic results: parsing output: 32/ for test: kms_selftest results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_media_vme results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_ctx_engines results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: perf results: parsing output: 39/ for test: gem_set_tiling_vs_blt results: parsing output: 40/ for test: kms_vblank results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: sysfs_preempt_timeout results: parsing output: 43/ for test: kms_cursor_crc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_exec_balancer results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: core_getversion results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_softpin results: parsing output: 50/ for test: vgem_basic results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: gem_exec_gttfill results: parsing output: 55/ for test: kms_setmode results: parsing output: 56/ for test: kms_busy results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: perf_pmu results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_cursor_edge_walk results: parsing output: 61/ for test: gem_exec_schedule results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: gem_render_copy_redux results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: kms_draw_crc results: parsing output: 68/ for test: kms_plane_cursor results: parsing output: 69/ for test: kms_getfb results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: gem_userptr_blits results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: vgem_basic results: parsing output: 74/ for test: i915_getparams_basic results: parsing output: 75/ for test: i915_drm_fdinfo results: parsing output: 76/ for test: kms_content_protection results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_pm_rpm results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_plane_scaling results: parsing output: 81/ for test: kms_psr2_sf results: parsing output: 82/ for test: gem_exec_reloc results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: i915_pm_rps results: parsing output: 85/ for test: prime_vgem results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_properties results: parsing output: 89/ for test: i915_suspend results: parsing output: 90/ for test: kms_chamelium_hpd results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: gem_userptr_blits results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: kms_atomic results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: syncobj_wait results: parsing output: 98/ for test: kms_color results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_mmap results: parsing output: 101/ for test: gem_workarounds results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_cursor_legacy results: parsing output: 105/ for test: kms_async_flips results: parsing output: 106/ for test: gem_barrier_race results: parsing output: 107/ for test: kms_big_fb results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_chamelium_audio results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: prime_mmap results: parsing output: 112/ for test: perf results: parsing output: 113/ for test: kms_flip results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: gem_pwrite results: parsing output: 116/ for test: kms_flip results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_chamelium_edid results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: kms_plane_alpha_blend results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: api_intel_allocator results: parsing output: 127/ for test: kms_cursor_legacy results: parsing output: 128/ for test: gem_ctx_shared results: parsing output: 129/ for test: gem_exec_fence results: parsing output: 130/ for test: i915_query results: parsing output: 131/ for test: gem_softpin results: parsing output: 132/ for test: gem_readwrite Done.