[55.950106] Initializing watchdogs [55.950154] /dev/watchdog0 [55.963440] [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] [55.967754] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.969866] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.973258] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [56.122506] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [56.126870] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [56.266108] [002/131] (960s left) gem_exec_fence (submit3) [56.452807] Starting subtest: submit3 [56.457846] Subtest submit3: SKIP (0.000s) [58.005242] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [58.008233] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [58.106144] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [58.110081] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [58.228917] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [58.334301] Starting subtest: fbc-rgb101010-draw-mmap-wc [62.926617] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.595s) [64.063102] [005/131] (952s left) gem_exec_balancer (noheartbeat) [64.323497] Starting subtest: noheartbeat [64.328426] Subtest noheartbeat: SKIP (0.000s) [64.449612] [006/131] (952s left) kms_chamelium_color (ctm-blue-to-red) [64.549325] Subtest ctm-blue-to-red: SKIP (0.000s) [64.616507] [007/131] (952s left) gem_workarounds (suspend-resume) [64.688888] Starting subtest: suspend-resume [80.477214] Subtest suspend-resume: SUCCESS (5.556s) [80.638330] [008/131] (936s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [80.746982] Starting subtest: planes-downscale-factor-0-75-unity-scaling [80.749407] Starting dynamic subtest: pipe-A [80.810352] Dynamic subtest pipe-A: SUCCESS (0.065s) [80.822088] Starting dynamic subtest: pipe-B [81.954962] Dynamic subtest pipe-B: SUCCESS (1.142s) [81.968589] Starting dynamic subtest: pipe-C [83.064325] Dynamic subtest pipe-C: SUCCESS (1.108s) [83.077059] Starting dynamic subtest: pipe-D [84.195155] Dynamic subtest pipe-D: SUCCESS (1.129s) [84.197663] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.448s) [85.374905] [009/131] (931s left) gem_pxp (create-regular-buffer) [85.490089] Starting subtest: create-regular-buffer [85.492672] Subtest create-regular-buffer: SUCCESS (0.000s) [85.628100] [010/131] (931s left) gem_exec_params (rel-constants-invalid-rel-gen5) [85.690145] Starting subtest: rel-constants-invalid-rel-gen5 [85.692702] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [85.814623] [011/131] (931s left) gem_exec_nop (basic-series) [85.897071] Starting subtest: basic-series [102.164132] Subtest basic-series: SUCCESS (16.274s) [102.426818] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [102.530938] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [102.535482] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [102.656493] [013/131] (914s left) kms_psr (fbc-psr-primary-page-flip) [102.761705] Starting subtest: fbc-psr-primary-page-flip [102.763668] Starting dynamic subtest: eDP-1 [102.767818] Dynamic subtest eDP-1: SKIP (0.000s) [102.771991] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [102.868174] [014/131] (914s left) i915_pm_rps (engine-order) [102.927866] Starting subtest: engine-order [107.734753] Subtest engine-order: SUCCESS (4.806s) [107.892524] [015/131] (909s left) gem_softpin (evict-active) [107.960633] Starting subtest: evict-active [107.970844] Subtest evict-active: SUCCESS (0.010s) [108.135363] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [108.190849] Starting subtest: wait-delayed-signal [108.294181] Subtest wait-delayed-signal: SUCCESS (0.102s) [108.401082] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [108.504098] Starting subtest: atomic-fastset [108.506632] Starting dynamic subtest: pipe-A-eDP-1 [108.647786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s) [108.658644] Starting dynamic subtest: pipe-B-eDP-1 [109.908535] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s) [109.920094] Starting dynamic subtest: pipe-C-eDP-1 [111.104928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s) [111.115314] Starting dynamic subtest: pipe-D-eDP-1 [112.247828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s) [112.250480] Subtest atomic-fastset: SUCCESS (3.743s) [113.527259] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [113.639093] Starting subtest: x-tiled-16bpp-rotate-270 [113.658435] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [113.830001] [019/131] (903s left) api_intel_bb (render-ccs) [113.899033] Starting subtest: render-ccs [114.256118] Subtest render-ccs: SUCCESS (0.356s) [114.372388] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [114.475845] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [114.478087] Starting dynamic subtest: pipe-A-eDP-1 [114.500005] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [114.510878] Starting dynamic subtest: pipe-B-eDP-1 [114.532797] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [114.542693] Starting dynamic subtest: pipe-C-eDP-1 [114.565144] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [114.574538] Starting dynamic subtest: pipe-D-eDP-1 [114.596067] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [114.600421] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [116.795413] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [116.856189] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [116.965704] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [117.064463] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [117.166090] Starting subtest: psr-2p-primscrn-cur-indfb-move [117.170767] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [117.300879] [023/131] (900s left) gem_lmem_swapping (heavy-multi) [117.348167] Subtest heavy-multi: SKIP (0.000s) [117.392790] [024/131] (900s left) kms_async_flips (test-cursor) [117.491821] Starting subtest: test-cursor [117.495829] Subtest test-cursor: SKIP (0.000s) [118.728792] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [123.691155] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [123.693679] Starting dynamic subtest: pipe-A-eDP-1 [124.481218] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s) [124.491782] Starting dynamic subtest: pipe-B-eDP-1 [125.618601] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s) [125.622959] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.926s) [126.836464] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [126.939889] Starting subtest: 2x-tiling-4 [126.944094] Subtest 2x-tiling-4: SKIP (0.000s) [127.037719] [027/131] (890s left) gem_ctx_param (invalid-param-set) [127.096213] Starting subtest: invalid-param-set [127.098729] Subtest invalid-param-set: SUCCESS (0.000s) [127.192291] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [127.286979] Starting subtest: bad-pixel-format-y-tiled-ccs [127.289197] Starting dynamic subtest: pipe-A-eDP-1 [127.311066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [127.321672] Starting dynamic subtest: pipe-B-eDP-1 [127.342293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [127.350112] Starting dynamic subtest: pipe-C-eDP-1 [127.370349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [127.378009] Starting dynamic subtest: pipe-D-eDP-1 [127.398726] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [127.402784] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [129.510789] [029/131] (888s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [129.619850] Starting subtest: plane-downscale-factor-0-5-with-modifiers [129.622116] Starting dynamic subtest: pipe-A [129.639609] Dynamic subtest pipe-A: SKIP (0.017s) [129.649240] Starting dynamic subtest: pipe-B [129.669458] Dynamic subtest pipe-B: SKIP (0.031s) [129.679668] Starting dynamic subtest: pipe-C [129.699525] Dynamic subtest pipe-C: SKIP (0.029s) [129.708056] Starting dynamic subtest: pipe-D [129.729536] Dynamic subtest pipe-D: SKIP (0.029s) [129.733250] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.107s) [129.846570] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [129.911340] Starting subtest: multi-wait-all-available-submitted-signaled [129.913660] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [130.049624] [031/131] (887s left) perf (missing-sample-flags) [130.192990] Starting subtest: missing-sample-flags [130.194871] Subtest missing-sample-flags: SUCCESS (0.000s) [130.231450] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [130.337304] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [136.532097] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.199s) [137.705362] [033/131] (880s left) kms_pm_rpm (system-suspend-idle) [139.273392] Starting subtest: system-suspend-idle [159.011002] Subtest system-suspend-idle: SUCCESS (4.621s) [159.401707] [034/131] (858s left) kms_vblank (wait-forked) [159.512302] Starting subtest: wait-forked [159.515134] Starting dynamic subtest: pipe-A-eDP-1 [161.316318] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s) [161.332977] Starting dynamic subtest: pipe-D-eDP-1 [163.782428] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s) [163.785256] Subtest wait-forked: SUCCESS (4.266s) [164.679176] [035/131] (853s left) kms_big_fb (y-tiled-32bpp-rotate-0) [164.794297] Starting subtest: y-tiled-32bpp-rotate-0 [164.799571] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [164.908549] [036/131] (853s left) kms_pipe_crc_basic (read-crc) [165.006423] Starting subtest: read-crc [165.009114] Starting dynamic subtest: pipe-A-eDP-1 [165.705088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s) [165.716544] Starting dynamic subtest: pipe-B-eDP-1 [167.046220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.338s) [167.056973] Starting dynamic subtest: pipe-C-eDP-1 [168.352383] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s) [168.362443] Starting dynamic subtest: pipe-D-eDP-1 [169.738551] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.384s) [169.741404] Subtest read-crc: SUCCESS (4.727s) [170.642759] [037/131] (847s left) kms_cursor_legacy (single-move) [170.779809] Starting subtest: single-move [170.782216] Starting dynamic subtest: pipe-A [176.164385] Dynamic subtest pipe-A: SUCCESS (5.380s) [176.174419] Starting dynamic subtest: pipe-B [181.549244] Dynamic subtest pipe-B: SUCCESS (5.379s) [181.560150] Starting dynamic subtest: pipe-C [186.928407] Dynamic subtest pipe-C: SUCCESS (5.378s) [186.939392] Starting dynamic subtest: pipe-D [192.308989] Dynamic subtest pipe-D: SUCCESS (5.379s) [192.319783] Starting dynamic subtest: all-pipes [197.693578] Dynamic subtest all-pipes: SUCCESS (5.386s) [197.696203] Subtest single-move: SUCCESS (26.909s) [197.885784] [038/131] (820s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [202.904838] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [202.910200] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [203.787129] [039/131] (814s left) gem_unref_active_buffers [203.983839] [040/131] (814s left) kms_psr (fbc-psr2-primary-mmap-gtt) [204.078203] Starting subtest: fbc-psr2-primary-mmap-gtt [204.080419] Starting dynamic subtest: eDP-1 [204.085175] Dynamic subtest eDP-1: SKIP (0.000s) [204.090141] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [204.174276] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [204.236989] Starting subtest: invalid-signal-zero-handles [204.240178] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [204.358966] [042/131] (813s left) gen9_exec_parse (bb-oversize) [204.419727] Subtest bb-oversize: SKIP (0.000s) [204.487786] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [204.546579] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [204.654233] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s) [204.752851] [044/131] (813s left) gem_exec_reloc (basic-write-cpu-noreloc) [204.817771] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [204.900281] [045/131] (813s left) gem_mmap_offset (bad-flags) [204.961677] Starting subtest: bad-flags [204.964395] Subtest bad-flags: SUCCESS (0.000s) [205.093481] [046/131] (813s left) kms_cursor_legacy (cursor-vs-flip-legacy) [205.211667] Starting subtest: cursor-vs-flip-legacy [234.475458] Subtest cursor-vs-flip-legacy: SUCCESS (29.261s) [235.311811] [047/131] (783s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [235.406206] Starting subtest: sprite-rotation-90-pos-100-0 [235.411029] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [235.501672] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [235.597141] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [236.620197] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s) [236.801990] [049/131] (781s left) gem_create (busy-create) [236.859787] Starting subtest: busy-create [236.861821] Starting dynamic subtest: smem0 [270.253997] Dynamic subtest smem0: SUCCESS (33.393s) [270.257075] Subtest busy-create: SUCCESS (33.394s) [270.466131] [050/131] (748s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [270.570299] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [274.725789] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.161s) [275.902864] [051/131] (742s left) perf (invalid-open-flags) [276.016126] Starting subtest: invalid-open-flags [276.018836] Subtest invalid-open-flags: SUCCESS (0.000s) [276.057807] [052/131] (742s left) perf (oa-formats) [276.159250] Starting subtest: oa-formats [276.162155] Starting dynamic subtest: 0-rcs0 [276.172094] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [276.182168] Starting dynamic subtest: 1-vcs1 [276.195973] Dynamic subtest 1-vcs1: SUCCESS (0.023s) [276.198283] Subtest oa-formats: SUCCESS (0.040s) [276.239124] [053/131] (742s left) kms_big_fb (4-tiled-8bpp-rotate-270) [276.329922] Starting subtest: 4-tiled-8bpp-rotate-270 [276.353145] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.023s) [276.478256] [054/131] (742s left) kms_cursor_crc (cursor-onscreen-64x21) [276.674134] Starting subtest: cursor-onscreen-64x21 [276.720899] Subtest cursor-onscreen-64x21: SKIP (0.041s) [276.970158] [055/131] (741s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [277.059747] Starting subtest: primary-4-tiled-reflect-x-180 [284.287086] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.227s) [285.466852] [056/131] (733s left) kms_cursor_crc (cursor-onscreen-256x256) [285.724367] Starting subtest: cursor-onscreen-256x256 [285.727092] Starting dynamic subtest: pipe-A-eDP-1 [287.853233] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.128s) [287.882933] Starting dynamic subtest: pipe-D-eDP-1 [290.675554] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s) [290.677731] Subtest cursor-onscreen-256x256: SUCCESS (4.952s) [291.538730] [057/131] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [291.640235] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [298.845070] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.206s) [298.995975] [058/131] (719s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [299.100377] Starting subtest: async-flip-with-page-flip-events-tiled [299.478094] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [302.200705] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.723s) [302.210400] Starting dynamic subtest: pipe-A-eDP-1-4 [304.376586] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [304.388733] Starting dynamic subtest: pipe-A-eDP-1-4 [306.385736] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [306.396338] Starting dynamic subtest: pipe-A-eDP-1-x [308.577692] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.191s) [308.941390] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [311.725723] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.790s) [311.737811] Starting dynamic subtest: pipe-B-eDP-1-4 [313.923252] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.197s) [313.935202] Starting dynamic subtest: pipe-B-eDP-1-4 [315.933413] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [315.946232] Starting dynamic subtest: pipe-B-eDP-1-x [318.123417] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [318.489292] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [321.259148] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.777s) [321.269462] Starting dynamic subtest: pipe-C-eDP-1-4 [323.446300] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.186s) [323.456123] Starting dynamic subtest: pipe-C-eDP-1-4 [325.456206] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [325.471951] Starting dynamic subtest: pipe-C-eDP-1-x [327.646297] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [328.011108] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [330.791154] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.787s) [330.800406] Starting dynamic subtest: pipe-D-eDP-1-4 [332.966958] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [332.977148] Starting dynamic subtest: pipe-D-eDP-1-4 [334.978820] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [334.989839] Starting dynamic subtest: pipe-D-eDP-1-x [337.166968] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s) [337.169391] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.064s) [338.400813] [059/131] (680s left) perf (polling) [338.502393] Starting subtest: polling [338.505139] Starting dynamic subtest: 0-rcs0 [348.522779] Dynamic subtest 0-rcs0: SUCCESS (10.017s) [348.531809] Starting dynamic subtest: 1-vcs1 [358.544700] Dynamic subtest 1-vcs1: SUCCESS (10.019s) [358.547641] Subtest polling: SUCCESS (20.038s) [358.595883] [060/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [358.710537] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [358.715169] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [358.849477] [061/131] (660s left) syncobj_timeline (reset-signaled) [358.910992] Starting subtest: reset-signaled [358.913753] Subtest reset-signaled: SUCCESS (0.000s) [359.053826] [062/131] (659s left) kms_rmfb (rmfb-ioctl) [359.153202] Starting subtest: rmfb-ioctl [359.155692] Starting dynamic subtest: pipe-A-eDP-1 [359.256706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [359.268176] Starting dynamic subtest: pipe-B-eDP-1 [360.421949] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s) [360.435966] Starting dynamic subtest: pipe-C-eDP-1 [361.637587] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s) [361.650094] Starting dynamic subtest: pipe-D-eDP-1 [362.771952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [362.774415] Subtest rmfb-ioctl: SUCCESS (3.622s) [364.015967] [063/131] (655s left) gem_userptr_blits (create-destroy-sync) [364.104982] Starting subtest: create-destroy-sync [369.119409] Subtest create-destroy-sync: SUCCESS (5.014s) [369.266085] [064/131] (649s left) gem_exec_reloc (basic-gtt-cpu-active) [369.330152] Subtest basic-gtt-cpu-active: SKIP (0.000s) [369.417148] [065/131] (649s left) api_intel_allocator (execbuf-with-allocator) [369.473062] Starting subtest: execbuf-with-allocator [369.479963] Subtest execbuf-with-allocator: SUCCESS (0.009s) [369.638692] [066/131] (649s left) kms_lease (cursor-implicit-plane) [369.737669] Starting subtest: cursor-implicit-plane [369.740095] Starting dynamic subtest: pipe-A-eDP-1 [370.187727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s) [370.196980] Starting dynamic subtest: pipe-B-eDP-1 [371.309184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s) [371.318849] Starting dynamic subtest: pipe-C-eDP-1 [372.413773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s) [372.424673] Starting dynamic subtest: pipe-D-eDP-1 [373.566099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s) [373.568791] Subtest cursor-implicit-plane: SUCCESS (3.830s) [374.449858] [067/131] (644s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [374.572128] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [374.577412] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [374.740579] [068/131] (644s left) syncobj_wait (invalid-signal-illegal-handle) [374.800400] Starting subtest: invalid-signal-illegal-handle [374.803275] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [374.915039] [069/131] (644s left) kms_psr (psr-primary-blt) [375.016381] Starting subtest: psr-primary-blt [375.019097] Starting dynamic subtest: eDP-1 [376.829219] Dynamic subtest eDP-1: SUCCESS (1.812s) [376.832082] Subtest psr-primary-blt: SUCCESS (1.813s) [377.703268] [070/131] (641s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [377.813229] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [377.815862] Starting dynamic subtest: pipe-A-eDP-1 [377.882898] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [377.893166] Starting dynamic subtest: pipe-B-eDP-1 [377.959512] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [377.969427] Starting dynamic subtest: pipe-C-eDP-1 [378.029375] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [378.038061] Starting dynamic subtest: pipe-D-eDP-1 [378.095847] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [378.100130] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [380.165607] [071/131] (639s left) kms_psr (pr-primary-blt) [380.258783] Starting subtest: pr-primary-blt [380.263506] Subtest pr-primary-blt: SKIP (0.000s) [380.352942] [072/131] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [380.444762] Starting subtest: psr-2p-primscrn-spr-indfb-move [380.449312] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [380.567980] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [380.669188] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [380.672137] Starting dynamic subtest: pipe-A-default-mode [381.800277] Dynamic subtest pipe-A-default-mode: SKIP (1.130s) [381.805414] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.132s) [381.972937] [074/131] (637s left) gem_exec_schedule (u-semaphore-noskip) [382.055572] Starting subtest: u-semaphore-noskip [382.452437] Subtest u-semaphore-noskip: SUCCESS (0.405s) [382.841236] [075/131] (636s left) i915_drm_fdinfo (memory-info-idle) [382.887666] Starting subtest: memory-info-idle [382.890313] Starting dynamic subtest: smem0 [382.939423] Dynamic subtest smem0: SUCCESS (0.053s) [382.942423] Subtest memory-info-idle: SUCCESS (0.054s) [383.037260] [076/131] (636s left) i915_selftest (live) [386.564102] Starting subtest: live [386.567017] Starting dynamic subtest: sanitycheck [390.589203] Dynamic subtest sanitycheck: SUCCESS (4.025s) [390.604146] Starting dynamic subtest: uncore [394.724194] Dynamic subtest uncore: SUCCESS (4.134s) [394.734022] Starting dynamic subtest: workarounds [399.351995] Dynamic subtest workarounds: SUCCESS (4.627s) [399.362515] Starting dynamic subtest: gt_engines [405.420783] Dynamic subtest gt_engines: SUCCESS (6.067s) [405.430810] Starting dynamic subtest: gt_timelines [422.485782] Dynamic subtest gt_timelines: SUCCESS (17.064s) [422.496056] Starting dynamic subtest: gt_contexts [428.160048] Dynamic subtest gt_contexts: SUCCESS (5.672s) [428.170775] Starting dynamic subtest: gt_lrc [433.856198] Dynamic subtest gt_lrc: SUCCESS (5.694s) [433.866340] Starting dynamic subtest: gt_mocs [438.178702] Dynamic subtest gt_mocs: SUCCESS (4.321s) [438.188297] Starting dynamic subtest: gt_pm [446.365658] Dynamic subtest gt_pm: SUCCESS (8.185s) [446.375915] Starting dynamic subtest: gt_heartbeat [450.464900] Dynamic subtest gt_heartbeat: SUCCESS (4.097s) [450.474204] Starting dynamic subtest: gt_tlb [461.301630] Dynamic subtest gt_tlb: SUCCESS (10.834s) [461.316866] Starting dynamic subtest: requests [474.264391] Dynamic subtest requests: SUCCESS (12.959s) [474.274308] Starting dynamic subtest: migrate [483.605881] Dynamic subtest migrate: SUCCESS (9.339s) [483.616007] Starting dynamic subtest: active [487.701075] Dynamic subtest active: SUCCESS (4.093s) [487.711428] Starting dynamic subtest: objects [492.319994] Dynamic subtest objects: SUCCESS (4.617s) [492.330441] Starting dynamic subtest: mman [497.150177] Dynamic subtest mman: SUCCESS (4.828s) [497.160005] Starting dynamic subtest: dmabuf [501.373676] Dynamic subtest dmabuf: SUCCESS (4.221s) [501.383994] Starting dynamic subtest: vma [505.535960] Dynamic subtest vma: SUCCESS (4.160s) [505.545899] Starting dynamic subtest: coherency [510.364631] Dynamic subtest coherency: SUCCESS (4.826s) [510.379944] Starting dynamic subtest: gtt [523.585087] Dynamic subtest gtt: SUCCESS (13.217s) [523.599892] Starting dynamic subtest: gem [533.090181] Dynamic subtest gem: SUCCESS (9.502s) [533.100101] Starting dynamic subtest: evict [539.825690] Dynamic subtest evict: SUCCESS (6.732s) [539.836298] Starting dynamic subtest: hugepages [550.251179] Dynamic subtest hugepages: SUCCESS (10.423s) [550.261401] Starting dynamic subtest: gem_contexts [578.322324] Dynamic subtest gem_contexts: SUCCESS (28.066s) [578.332777] Starting dynamic subtest: client [582.508312] Dynamic subtest client: SUCCESS (4.183s) [582.518556] Starting dynamic subtest: gem_migrate [586.562324] Dynamic subtest gem_migrate: SUCCESS (4.052s) [586.573396] Starting dynamic subtest: reset [592.267263] Dynamic subtest reset: SUCCESS (5.702s) [592.277120] Starting dynamic subtest: memory_region [598.001954] Dynamic subtest memory_region: SUCCESS (5.731s) [598.012172] Starting dynamic subtest: hangcheck [612.678966] Dynamic subtest hangcheck: SUCCESS (14.673s) [612.689244] Starting dynamic subtest: execlists [616.829922] Dynamic subtest execlists: SUCCESS (4.148s) [616.840342] Starting dynamic subtest: ring_submission [620.831196] Dynamic subtest ring_submission: SUCCESS (3.999s) [620.841302] Starting dynamic subtest: perf [626.575026] Dynamic subtest perf: SUCCESS (5.742s) [626.585381] Starting dynamic subtest: slpc [640.090530] Dynamic subtest slpc: SUCCESS (13.512s) [640.100198] Starting dynamic subtest: guc [645.429897] Dynamic subtest guc: SUCCESS (5.338s) [645.439512] Starting dynamic subtest: guc_multi_lrc [649.482105] Dynamic subtest guc_multi_lrc: SUCCESS (4.050s) [649.497309] Starting dynamic subtest: guc_hang [655.736782] Dynamic subtest guc_hang: SUCCESS (6.253s) [655.746783] Starting dynamic subtest: late_gt_pm [661.531781] Dynamic subtest late_gt_pm: SUCCESS (5.793s) [661.534774] Subtest live: SUCCESS (274.953s) [661.565403] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [661.566085] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [661.569759] [077/131] (358s left) gem_userptr_blits (nohangcheck) [664.403089] Starting subtest: nohangcheck [664.639262] Subtest nohangcheck: SUCCESS (0.236s) [664.736763] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [664.737971] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [664.742061] [078/131] (354s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [664.844514] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [664.847228] Starting dynamic subtest: pipe-A-eDP-1 [665.706970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s) [665.717197] Starting dynamic subtest: pipe-B-eDP-1 [667.280971] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.573s) [667.290161] Starting dynamic subtest: pipe-C-eDP-1 [668.845719] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s) [668.855534] Starting dynamic subtest: pipe-D-eDP-1 [670.374608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s) [670.376972] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.523s) [671.579532] [079/131] (348s left) gem_softpin (allocator-nopin) [671.637367] Starting subtest: allocator-nopin [671.726717] Subtest allocator-nopin: SUCCESS (0.089s) [671.865767] [080/131] (347s left) kms_draw_crc (draw-method-pwrite) [671.954388] Starting subtest: draw-method-pwrite [671.956380] Starting dynamic subtest: xrgb8888-untiled [672.576969] Dynamic subtest xrgb8888-untiled: SUCCESS (0.623s) [672.586247] Starting dynamic subtest: rgb565-untiled [673.099199] Dynamic subtest rgb565-untiled: SUCCESS (0.522s) [673.109100] Starting dynamic subtest: xrgb2101010-untiled [673.743423] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.643s) [673.753221] Starting dynamic subtest: xbgr16161616f-untiled [674.543280] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s) [674.553189] Starting dynamic subtest: xrgb8888-xtiled [676.655940] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.111s) [676.676478] Starting dynamic subtest: rgb565-xtiled [678.055407] Dynamic subtest rgb565-xtiled: SUCCESS (1.396s) [678.072655] Starting dynamic subtest: xrgb2101010-xtiled [680.187250] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.132s) [680.196764] Starting dynamic subtest: xbgr16161616f-xtiled [683.788109] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.599s) [683.799193] Starting dynamic subtest: xrgb8888-4tiled [685.065015] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.277s) [685.074405] Starting dynamic subtest: rgb565-4tiled [685.744395] Dynamic subtest rgb565-4tiled: SUCCESS (0.677s) [685.753433] Starting dynamic subtest: xrgb2101010-4tiled [687.020406] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.277s) [687.029270] Starting dynamic subtest: xbgr16161616f-4tiled [690.431976] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.410s) [690.434392] Subtest draw-method-pwrite: SUCCESS (18.480s) [690.572722] [081/131] (329s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [690.671938] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [690.677205] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [690.807656] [082/131] (329s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [690.904750] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [690.909406] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [691.030550] [083/131] (328s left) syncobj_timeline (host-signal-points) [691.101261] Starting subtest: host-signal-points [691.104091] Subtest host-signal-points: SUCCESS (0.004s) [691.233287] [084/131] (328s left) gem_mmap_gtt (basic-small-bo) [691.304924] Subtest basic-small-bo: SKIP (0.000s) [691.364706] [085/131] (328s left) perf_pmu (semaphore-wait-idle) [691.404727] Starting subtest: semaphore-wait-idle [691.407052] Starting dynamic subtest: rcs0 [691.916970] Dynamic subtest rcs0: SUCCESS (0.514s) [691.929165] Starting dynamic subtest: bcs0 [692.430236] Dynamic subtest bcs0: SUCCESS (0.510s) [692.442234] Starting dynamic subtest: vcs0 [692.943713] Dynamic subtest vcs0: SUCCESS (0.510s) [692.956238] Starting dynamic subtest: vcs1 [693.454831] Dynamic subtest vcs1: SUCCESS (0.510s) [693.466978] Starting dynamic subtest: vecs0 [693.971394] Dynamic subtest vecs0: SUCCESS (0.512s) [693.984208] Starting dynamic subtest: ccs0 [694.486848] Dynamic subtest ccs0: SUCCESS (0.513s) [694.489846] Subtest semaphore-wait-idle: SUCCESS (3.085s) [694.648145] [086/131] (325s left) kms_addfb_basic (no-handle) [694.706271] Starting subtest: no-handle [694.709205] Subtest no-handle: SUCCESS (0.000s) [694.877657] [087/131] (325s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [694.977047] Starting subtest: fbcpsr-rgb101010-draw-pwrite [701.910851] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.937s) [702.047062] [088/131] (318s left) gem_render_copy (yf-tiled-ccs-to-linear) [702.108072] Starting subtest: yf-tiled-ccs-to-linear [702.114149] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [702.322397] [089/131] (317s left) kms_flip (wf_vblank-ts-check) [702.421303] Starting subtest: wf_vblank-ts-check [702.424292] Starting dynamic subtest: A-eDP1 [711.379387] Dynamic subtest A-eDP1: SUCCESS (8.958s) [711.394575] Starting dynamic subtest: B-eDP1 [720.302801] Dynamic subtest B-eDP1: SUCCESS (8.920s) [720.317828] Starting dynamic subtest: C-eDP1 [729.218948] Dynamic subtest C-eDP1: SUCCESS (8.914s) [729.232089] Starting dynamic subtest: D-eDP1 [738.137137] Dynamic subtest D-eDP1: SUCCESS (8.915s) [738.139878] Subtest wf_vblank-ts-check: SUCCESS (35.720s) [739.389572] [090/131] (280s left) gem_exec_schedule (deep) [739.596296] Starting subtest: deep [739.598771] Starting dynamic subtest: rcs0 [744.326094] Dynamic subtest rcs0: SKIP (4.730s) [744.335723] Starting dynamic subtest: vcs0 [754.879574] Dynamic subtest vcs0: SUCCESS (10.554s) [754.889519] Starting dynamic subtest: vcs1 [766.007762] Dynamic subtest vcs1: SUCCESS (11.127s) [766.021897] Starting dynamic subtest: vecs0 [776.990496] Dynamic subtest vecs0: SUCCESS (10.982s) [777.002978] Starting dynamic subtest: ccs0 [789.280742] Dynamic subtest ccs0: SUCCESS (12.288s) [789.284535] Subtest deep: SUCCESS (49.686s) [790.273992] [091/131] (229s left) kms_sequence (queue-idle) [790.378381] Starting subtest: queue-idle [790.380388] Starting dynamic subtest: pipe-A-eDP-1 [792.192943] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s) [792.202273] Starting dynamic subtest: pipe-B-eDP-1 [794.630540] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.436s) [794.641016] Starting dynamic subtest: pipe-C-eDP-1 [797.054162] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.422s) [797.065410] Starting dynamic subtest: pipe-D-eDP-1 [799.488341] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s) [799.491428] Subtest queue-idle: SUCCESS (9.109s) [800.321455] [092/131] (219s left) gem_gtt_cpu_tlb [800.441329] [093/131] (219s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [800.549394] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [807.037326] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.491s) [807.193269] [094/131] (213s left) gem_eio (create-ext) [807.415857] Starting subtest: create-ext [807.731137] Subtest create-ext: SUCCESS (0.314s) [807.894633] [095/131] (212s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [807.970242] Subtest writes-after-reads-uncached: SKIP (0.000s) [808.053599] [096/131] (212s left) sysfs_preempt_timeout (idempotent) [808.111430] Starting subtest: idempotent [808.114050] Starting dynamic subtest: vecs0 [808.116258] Dynamic subtest vecs0: SUCCESS (0.000s) [808.126211] Starting dynamic subtest: ccs0 [808.128714] Dynamic subtest ccs0: SUCCESS (0.000s) [808.137749] Starting dynamic subtest: vcs0 [808.139956] Dynamic subtest vcs0: SUCCESS (0.000s) [808.150235] Starting dynamic subtest: bcs0 [808.152400] Dynamic subtest bcs0: SUCCESS (0.000s) [808.163431] Starting dynamic subtest: rcs0 [808.165704] Dynamic subtest rcs0: SUCCESS (0.000s) [808.174682] Starting dynamic subtest: vcs1 [808.176442] Dynamic subtest vcs1: SUCCESS (0.000s) [808.178155] Subtest idempotent: SUCCESS (0.006s) [808.241423] [097/131] (212s left) gem_busy (semaphore) [808.434044] Subtest semaphore: SKIP (0.000s) [808.687558] [098/131] (211s left) sriov_basic (enable-vfs-bind-unbind-each) [808.746133] Starting subtest: enable-vfs-bind-unbind-each [808.748307] Starting dynamic subtest: numvfs-1 [808.831012] Dynamic subtest numvfs-1: FAIL (0.030s) [808.840586] Starting dynamic subtest: numvfs-2 [808.916406] Dynamic subtest numvfs-2: FAIL (0.003s) [808.926385] Starting dynamic subtest: numvfs-3 [809.001086] Dynamic subtest numvfs-3: FAIL (0.003s) [809.010393] Starting dynamic subtest: numvfs-4 [809.083942] Dynamic subtest numvfs-4: FAIL (0.003s) [809.093296] Starting dynamic subtest: numvfs-5 [809.168580] Dynamic subtest numvfs-5: FAIL (0.003s) [809.177536] Starting dynamic subtest: numvfs-6 [809.254122] Dynamic subtest numvfs-6: FAIL (0.004s) [809.264832] Starting dynamic subtest: numvfs-7 [809.350161] Dynamic subtest numvfs-7: FAIL (0.003s) [809.360259] Starting dynamic subtest: numvfs-random [809.444741] Dynamic subtest numvfs-random: FAIL (0.003s) [809.446942] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s) [809.487741] [099/131] (211s left) kms_pm_lpsp (screens-disabled) [810.597039] Starting subtest: screens-disabled [810.601916] Subtest screens-disabled: SKIP (0.000s) [810.691194] [100/131] (209s left) gem_exec_capture (capture-invisible) [810.759867] Starting subtest: capture-invisible [810.762429] Starting dynamic subtest: smem0 [810.767268] Dynamic subtest smem0: SKIP (0.000s) [810.772280] Subtest capture-invisible: SKIP (0.001s) [810.895090] [101/131] (209s left) gem_lmem_swapping (verify-ccs) [810.941106] Subtest verify-ccs: SKIP (0.000s) [810.984586] [102/131] (209s left) kms_joiner (basic-force-ultra-joiner) [811.086677] Starting subtest: basic-force-ultra-joiner [811.091249] Subtest basic-force-ultra-joiner: SKIP (0.000s) [811.175923] [103/131] (209s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [811.274810] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [817.742835] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.470s) [817.879740] [104/131] (202s left) kms_color (legacy-gamma) [817.973216] Starting subtest: legacy-gamma [817.975381] Starting dynamic subtest: pipe-A-eDP-1 [818.692167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s) [818.703538] Starting dynamic subtest: pipe-B-eDP-1 [820.089391] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s) [820.102270] Starting dynamic subtest: pipe-C-eDP-1 [821.482324] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s) [821.491789] Starting dynamic subtest: pipe-D-eDP-1 [822.815752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s) [822.818414] Subtest legacy-gamma: SUCCESS (4.844s) [823.644807] [105/131] (197s left) gem_exec_schedule (wide) [823.831185] Starting subtest: wide [823.833883] Starting dynamic subtest: rcs0 [834.553578] Dynamic subtest rcs0: SUCCESS (10.720s) [834.566150] Starting dynamic subtest: vcs0 [845.731532] Dynamic subtest vcs0: SUCCESS (11.177s) [845.741902] Starting dynamic subtest: vcs1 [858.915922] Dynamic subtest vcs1: SUCCESS (13.182s) [858.928000] Starting dynamic subtest: vecs0 [872.041604] Dynamic subtest vecs0: SUCCESS (13.124s) [872.054423] Starting dynamic subtest: ccs0 [885.667536] Dynamic subtest ccs0: SUCCESS (13.624s) [885.670696] Subtest wide: SUCCESS (61.831s) [886.853206] [106/131] (134s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [886.977443] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [886.980179] Starting dynamic subtest: pipe-A-default-mode [887.277342] Dynamic subtest pipe-A-default-mode: SKIP (0.297s) [887.282952] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.298s) [888.185206] [107/131] (132s left) kms_big_fb (linear-64bpp-rotate-180) [888.276345] Starting subtest: linear-64bpp-rotate-180 [890.068771] Subtest linear-64bpp-rotate-180: SUCCESS (1.795s) [890.275431] [108/131] (130s left) gem_ppgtt (blt-vs-render-ctxn) [890.332395] Starting subtest: blt-vs-render-ctxN [923.563950] Subtest blt-vs-render-ctxN: SUCCESS (33.226s) [923.730183] [109/131] ( 97s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [923.883415] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [923.888429] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [923.995743] [110/131] ( 97s left) kms_chamelium_frames (dp-frame-dump) [924.398405] Subtest dp-frame-dump: SKIP (0.000s) [925.175763] [111/131] ( 95s left) kms_psr2_su (page_flip-nv12) [925.242638] Subtest page_flip-NV12: SKIP (0.000s) [925.313335] [112/131] ( 95s left) gem_tiling_max_stride [925.453600] [113/131] ( 95s left) perf_pmu (busy-idle) [925.492361] Starting subtest: busy-idle [925.495257] Starting dynamic subtest: rcs0 [926.204637] Dynamic subtest rcs0: SUCCESS (0.716s) [926.216429] Starting dynamic subtest: bcs0 [926.878157] Dynamic subtest bcs0: SUCCESS (0.671s) [926.889407] Starting dynamic subtest: vcs0 [928.282469] Dynamic subtest vcs0: SUCCESS (1.401s) [928.294444] Starting dynamic subtest: vcs1 [930.202147] Dynamic subtest vcs1: SUCCESS (1.916s) [930.220028] Starting dynamic subtest: vecs0 [932.250315] Dynamic subtest vecs0: SUCCESS (2.045s) [932.263279] Starting dynamic subtest: ccs0 [932.917093] Dynamic subtest ccs0: SUCCESS (0.665s) [932.919844] Subtest busy-idle: SUCCESS (7.429s) [933.040432] [114/131] ( 88s left) dmabuf_sync_file (export-before-signal) [933.090705] Starting subtest: export-before-signal [933.093256] Subtest export-before-signal: SUCCESS (0.001s) [933.170824] [115/131] ( 88s left) gem_exec_reloc (basic-cpu-read) [933.237565] Subtest basic-cpu-read: SKIP (0.000s) [933.319779] [116/131] ( 87s left) kms_hdr (bpc-switch) [933.418772] Starting subtest: bpc-switch [934.468283] Starting dynamic subtest: pipe-A-eDP-1 [937.974522] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.507s) [937.977131] Subtest bpc-switch: SUCCESS (4.556s) [938.133773] [117/131] ( 83s left) perf (i915-ref-count) [938.267333] Starting subtest: i915-ref-count [938.337759] Subtest i915-ref-count: SUCCESS (0.068s) [938.396732] [118/131] ( 82s left) gem_ctx_isolation (nonpriv) [938.459200] Starting subtest: nonpriv [938.461938] Starting dynamic subtest: rcs0 [938.690380] Dynamic subtest rcs0: SUCCESS (0.231s) [938.704392] Starting dynamic subtest: bcs0 [938.982098] Dynamic subtest bcs0: SUCCESS (0.292s) [938.992220] Starting dynamic subtest: vcs0 [939.238117] Dynamic subtest vcs0: SUCCESS (0.255s) [939.250654] Starting dynamic subtest: vcs1 [940.488888] Dynamic subtest vcs1: SUCCESS (1.247s) [940.502832] Starting dynamic subtest: vecs0 [942.525414] Dynamic subtest vecs0: SUCCESS (2.036s) [942.537306] Starting dynamic subtest: ccs0 [944.587726] Dynamic subtest ccs0: SUCCESS (2.061s) [944.590552] Subtest nonpriv: SUCCESS (6.129s) [944.846599] [119/131] ( 76s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [944.907167] Starting subtest: y-tiled-to-vebox-x-tiled [944.912392] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [945.114981] [120/131] ( 76s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [945.215991] Starting subtest: plane-use-after-nonblocking-unbind [945.218591] Starting dynamic subtest: pipe-A-eDP-1 [945.277928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [945.587460] Starting dynamic subtest: pipe-B-eDP-1 [946.423237] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.846s) [946.723165] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.509s) [947.604730] [121/131] ( 73s left) i915_hangman (engine-error-state-capture) [947.679006] Starting subtest: engine-error-state-capture [947.681418] Starting dynamic subtest: rcs0 [951.223912] Dynamic subtest rcs0: SUCCESS (3.543s) [951.238141] Starting dynamic subtest: bcs0 [957.241191] Dynamic subtest bcs0: SUCCESS (6.014s) [957.255225] Starting dynamic subtest: vcs0 [963.194685] Dynamic subtest vcs0: SUCCESS (5.951s) [963.212757] Starting dynamic subtest: vcs1 [969.144605] Dynamic subtest vcs1: SUCCESS (5.947s) [969.157793] Starting dynamic subtest: vecs0 [974.200456] Dynamic subtest vecs0: SUCCESS (5.052s) [974.212430] Starting dynamic subtest: ccs0 [980.216760] Dynamic subtest ccs0: SUCCESS (6.012s) [980.219914] Subtest engine-error-state-capture: SUCCESS (32.535s) [980.325232] [122/131] ( 41s left) gem_exec_schedule (pi-shared-iova) [980.514798] Starting subtest: pi-shared-iova [980.517176] Starting dynamic subtest: rcs0 [980.658828] Dynamic subtest rcs0: SUCCESS (0.147s) [980.672269] Starting dynamic subtest: vcs0 [980.749152] Dynamic subtest vcs0: SUCCESS (0.089s) [980.762196] Starting dynamic subtest: vcs1 [980.835281] Dynamic subtest vcs1: SUCCESS (0.084s) [980.849282] Starting dynamic subtest: vecs0 [980.918413] Dynamic subtest vecs0: SUCCESS (0.082s) [980.932289] Starting dynamic subtest: ccs0 [981.051041] Dynamic subtest ccs0: SUCCESS (0.131s) [981.054200] Subtest pi-shared-iova: SUCCESS (0.539s) [982.375777] [123/131] ( 39s left) syncobj_wait (invalid-reset-illegal-handle) [982.432740] Starting subtest: invalid-reset-illegal-handle [982.435132] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [982.544023] [124/131] ( 39s left) syncobj_wait (single-wait-all-for-submit-signaled) [982.603091] Starting subtest: single-wait-all-for-submit-signaled [982.605943] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [982.749602] [125/131] ( 38s left) kms_cursor_crc (cursor-sliding-512x170) [983.054993] Starting subtest: cursor-sliding-512x170 [983.060261] Subtest cursor-sliding-512x170: SKIP (0.001s) [983.247761] [126/131] ( 38s left) kms_chamelium_hpd (hdmi-hpd-fast) [983.640298] Subtest hdmi-hpd-fast: SKIP (0.000s) [984.499412] [127/131] ( 37s left) gem_ctx_persistence (hostile) [984.562052] Starting subtest: hostile [994.721416] Subtest hostile: SUCCESS (10.157s) [994.900784] [128/131] ( 26s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [995.013386] Starting subtest: fbc-rgb565-draw-blt [999.218842] Subtest fbc-rgb565-draw-blt: SUCCESS (4.209s) [1000.442103] [129/131] ( 21s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [1000.537288] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [1009.775965] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.239s) [1009.955721] [130/131] ( 11s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [1010.053843] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [1010.059104] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [1010.175344] [131/131] ( 11s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [1010.277450] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [1010.282218] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [1010.408435] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.