[59.001313] Initializing watchdogs
[59.001360]   /dev/watchdog0
[59.029045] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.033660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.035967] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.037941] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[59.132300] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[62.827745] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.709s)
[63.996665] [002/133] (955s left) gem_exec_async (concurrent-writes)
[64.054965] Starting subtest: concurrent-writes
[64.056144] Starting dynamic subtest: rcs0
[64.074476] Dynamic subtest rcs0: SUCCESS (0.020s)
[64.084619] Starting dynamic subtest: bcs0
[64.085518] Dynamic subtest bcs0: SUCCESS (0.007s)
[64.091950] Starting dynamic subtest: vcs0
[64.092868] Dynamic subtest vcs0: SUCCESS (0.005s)
[64.098907] Starting dynamic subtest: vcs1
[64.099792] Dynamic subtest vcs1: SUCCESS (0.008s)
[64.105602] Starting dynamic subtest: vecs0
[64.106458] Dynamic subtest vecs0: SUCCESS (0.007s)
[64.112917] Starting dynamic subtest: ccs0
[64.113813] Dynamic subtest ccs0: SUCCESS (0.008s)
[64.114753] Subtest concurrent-writes: SUCCESS (0.057s)
[64.324734] [003/133] (955s left) kms_psr (pr-primary-blt)
[64.408296] Starting subtest: pr-primary-blt
[64.410179] Subtest pr-primary-blt: SKIP (0.000s)
[64.470977] [004/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[64.857673] Subtest dp-crc-fast: SKIP (0.000s)
[65.691289] [005/133] (953s left) gem_exec_schedule (pi-shared-iova)
[65.865488] Starting subtest: pi-shared-iova
[65.866693] Starting dynamic subtest: rcs0
[65.941411] Dynamic subtest rcs0: SUCCESS (0.077s)
[65.951541] Starting dynamic subtest: vcs0
[66.000998] Dynamic subtest vcs0: SUCCESS (0.058s)
[66.010053] Starting dynamic subtest: vcs1
[66.053172] Dynamic subtest vcs1: SUCCESS (0.053s)
[66.060310] Starting dynamic subtest: vecs0
[66.104417] Dynamic subtest vecs0: SUCCESS (0.050s)
[66.118549] Starting dynamic subtest: ccs0
[66.165484] Dynamic subtest ccs0: SUCCESS (0.061s)
[66.166503] Subtest pi-shared-iova: SUCCESS (0.302s)
[68.102721] [006/133] (951s left) kms_busy (basic-hang)
[68.193760] Starting subtest: basic-hang
[68.196291] Starting dynamic subtest: flip-pipe-A
[68.798587] Dynamic subtest flip-pipe-A: SUCCESS (0.604s)
[68.805400] Starting dynamic subtest: modeset-pipe-A
[72.230648] Dynamic subtest modeset-pipe-A: SUCCESS (3.435s)
[72.241406] Starting dynamic subtest: flip-pipe-D
[73.422640] Dynamic subtest flip-pipe-D: SUCCESS (1.192s)
[73.428965] Starting dynamic subtest: modeset-pipe-D
[76.867562] Dynamic subtest modeset-pipe-D: SUCCESS (3.446s)
[76.868558] Subtest basic-hang: SUCCESS (8.681s)
[77.656633] [007/133] (942s left) kms_flip (basic-flip-vs-dpms)
[77.755482] Starting subtest: basic-flip-vs-dpms
[77.757505] Starting dynamic subtest: A-eDP1
[80.359988] Dynamic subtest A-eDP1: SUCCESS (2.602s)
[80.366921] Starting dynamic subtest: B-eDP1
[82.534029] Dynamic subtest B-eDP1: SUCCESS (2.173s)
[82.548921] Starting dynamic subtest: C-eDP1
[84.634099] Dynamic subtest C-eDP1: SUCCESS (2.099s)
[84.641254] Starting dynamic subtest: D-eDP1
[86.797466] Dynamic subtest D-eDP1: SUCCESS (2.162s)
[86.801590] Subtest basic-flip-vs-dpms: SUCCESS (9.046s)
[87.601910] [008/133] (932s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[87.693318] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[87.694149] Starting dynamic subtest: pipe-A-default-mode
[90.436384] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s)
[90.437360] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.743s)
[91.286800] [009/133] (928s left) gem_tiled_swapping (non-threaded)
[91.336228] Subtest non-threaded: SKIP (0.000s)
[91.383751] [010/133] (928s left) kms_legacy_colorkey (invalid-plane)
[91.465424] Starting subtest: invalid-plane
[91.466337] Starting dynamic subtest: zero-id
[91.467210] Dynamic subtest zero-id: SUCCESS (0.000s)
[91.474176] Starting dynamic subtest: outrange-id
[91.474979] Dynamic subtest outrange-id: SUCCESS (0.000s)
[91.476025] Subtest invalid-plane: SUCCESS (0.001s)
[91.528360] [011/133] (928s left) gem_mmap_wc (write-wc-read-gtt)
[91.577346] Subtest write-wc-read-gtt: SKIP (0.000s)
[91.629171] [012/133] (928s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[91.668831] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[91.719880] [013/133] (928s left) kms_big_fb (linear-32bpp-rotate-0)
[91.824979] Starting subtest: linear-32bpp-rotate-0
[93.404282] Subtest linear-32bpp-rotate-0: SUCCESS (1.580s)
[93.543454] [014/133] (926s left) gen9_exec_parse (bb-start-far)
[93.597125] Subtest bb-start-far: SKIP (0.000s)
[93.665443] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[93.787203] Starting subtest: cursorB-vs-flipA-varying-size
[93.789833] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[93.923307] [016/133] (926s left) gem_lmem_swapping (verify)
[93.969451] Subtest verify: SKIP (0.000s)
[94.012453] [017/133] (926s left) gem_userptr_blits (mmap-offset-banned)
[94.075049] Starting subtest: mmap-offset-banned
[94.076057] Starting dynamic subtest: wb
[94.077050] Dynamic subtest wb: SUCCESS (0.000s)
[94.084671] Starting dynamic subtest: wc
[94.085644] Dynamic subtest wc: SUCCESS (0.000s)
[94.091863] Starting dynamic subtest: uc
[94.092815] Dynamic subtest uc: SUCCESS (0.000s)
[94.093754] Subtest mmap-offset-banned: SUCCESS (0.001s)
[94.192308] [018/133] (925s left) gem_softpin (evict-snoop-interruptible)
[94.237545] Starting subtest: evict-snoop-interruptible
[94.239335] Subtest evict-snoop-interruptible: SKIP (0.000s)
[94.345801] [019/133] (925s left) gem_ctx_persistence (legacy-engines-mixed-process)
[94.402152] Starting subtest: legacy-engines-mixed-process
[94.403994] Starting dynamic subtest: render
[95.829604] Dynamic subtest render: SUCCESS (1.427s)
[95.838552] Starting dynamic subtest: bsd1
[97.896622] Dynamic subtest bsd1: SUCCESS (2.066s)
[97.906697] Starting dynamic subtest: bsd2
[99.943546] Dynamic subtest bsd2: SUCCESS (2.045s)
[99.954028] Starting dynamic subtest: blt
[101.845392] Dynamic subtest blt: SUCCESS (1.901s)
[101.854090] Starting dynamic subtest: vebox
[103.910536] Dynamic subtest vebox: SUCCESS (2.064s)
[103.911741] Subtest legacy-engines-mixed-process: SUCCESS (9.508s)
[103.985824] [020/133] (916s left) gem_eio (hibernate)
[104.219039] Starting subtest: hibernate
[118.833355] Subtest hibernate: SUCCESS (14.615s)
[126.020614] [021/133] (901s left) i915_pm_rps (fence-order)
[126.095274] Starting subtest: fence-order
[129.503274] Subtest fence-order: SUCCESS (3.401s)
[129.635073] [022/133] (897s left) kms_vblank (ts-continuation-idle-hang)
[129.735160] Starting subtest: ts-continuation-idle-hang
[129.736054] Starting dynamic subtest: pipe-A-eDP-1
[156.707787] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.970s)
[156.718877] Starting dynamic subtest: pipe-D-eDP-1
[171.745691] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s)
[171.746681] Subtest ts-continuation-idle-hang: SUCCESS (42.009s)
[172.546848] [023/133] (854s left) perf (unprivileged-single-ctx-counters)
[172.680329] Starting subtest: unprivileged-single-ctx-counters
[172.681876] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[172.721657] [024/133] (854s left) kms_frontbuffer_tracking (fbc-tiling-4)
[172.820840] Starting subtest: fbc-tiling-4
[177.076731] Subtest fbc-tiling-4: SUCCESS (4.255s)
[178.278551] [025/133] (849s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[178.385293] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[185.089032] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.704s)
[185.189320] [026/133] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[185.287069] Starting subtest: crc-primary-suspend-y-tiled-ccs
[185.287914] Starting dynamic subtest: pipe-A-eDP-1
[185.291448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[185.299425] Starting dynamic subtest: pipe-B-eDP-1
[185.302852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[185.310967] Starting dynamic subtest: pipe-C-eDP-1
[185.314581] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[185.322383] Starting dynamic subtest: pipe-D-eDP-1
[185.325883] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[185.327617] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[187.539325] [027/133] (839s left) gem_spin_batch (engines)
[187.592320] Starting subtest: engines
[187.593569] Starting dynamic subtest: rcs0
[190.839777] Dynamic subtest rcs0: SUCCESS (3.236s)
[190.850477] Starting dynamic subtest: bcs0
[194.116916] Dynamic subtest bcs0: SUCCESS (3.239s)
[194.128073] Starting dynamic subtest: vcs0
[197.350967] Dynamic subtest vcs0: SUCCESS (3.232s)
[197.362063] Starting dynamic subtest: vcs1
[200.590544] Dynamic subtest vcs1: SUCCESS (3.238s)
[200.601783] Starting dynamic subtest: vecs0
[203.829757] Dynamic subtest vecs0: SUCCESS (3.237s)
[203.840477] Starting dynamic subtest: ccs0
[207.068907] Dynamic subtest ccs0: SUCCESS (3.237s)
[207.070646] Subtest engines: SUCCESS (19.429s)
[207.254801] [028/133] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[207.349116] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[214.429234] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.080s)
[214.582607] [029/133] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[214.667405] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[214.669056] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[214.758236] [030/133] (812s left) gem_partial_pwrite_pread (reads-snoop)
[214.817759] Subtest reads-snoop: SKIP (0.000s)
[214.885518] [031/133] (812s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[214.975984] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[216.054376] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.079s)
[216.160250] [032/133] (811s left) kms_getfb (getfb-reject-nv12)
[216.257174] Starting subtest: getfb-reject-nv12
[216.257969] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[216.349042] [033/133] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[216.431283] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[220.830728] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.400s)
[221.975975] [034/133] (805s left) perf_pmu (render-node-busy-idle)
[222.045150] Starting subtest: render-node-busy-idle
[222.046013] Starting dynamic subtest: rcs0
[222.736810] Dynamic subtest rcs0: SUCCESS (0.692s)
[222.748238] Starting dynamic subtest: bcs0
[223.405244] Dynamic subtest bcs0: SUCCESS (0.667s)
[223.417486] Starting dynamic subtest: vcs0
[224.927459] Dynamic subtest vcs0: SUCCESS (1.511s)
[224.938649] Starting dynamic subtest: vcs1
[226.911381] Dynamic subtest vcs1: SUCCESS (1.982s)
[226.921895] Starting dynamic subtest: vecs0
[228.895606] Dynamic subtest vecs0: SUCCESS (1.982s)
[228.906556] Starting dynamic subtest: ccs0
[229.553363] Dynamic subtest ccs0: SUCCESS (0.665s)
[229.554802] Subtest render-node-busy-idle: SUCCESS (7.510s)
[229.623531] [035/133] (798s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[229.726345] Starting subtest: yf-tiled-16bpp-rotate-90
[229.727998] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[229.810848] [036/133] (797s left) kms_content_protection (atomic)
[229.939200] Starting subtest: atomic
[229.941066] Subtest atomic: SKIP (0.000s)
[230.064367] [037/133] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[230.165841] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[230.167552] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[230.259221] [038/133] (797s left) kms_pm_rpm (fences-dpms)
[232.076747] Starting subtest: fences-dpms
[232.079285] Subtest fences-dpms: SKIP (0.000s)
[232.501236] [039/133] (795s left) gem_mmap_gtt (basic-write-read)
[232.552685] Subtest basic-write-read: SKIP (0.000s)
[232.601770] [040/133] (795s left) gem_exec_reloc (basic-write-cpu-active)
[232.652738] Subtest basic-write-cpu-active: SKIP (0.000s)
[232.719734] [041/133] (795s left) gem_eio (unwedge-stress)
[232.912514] Starting subtest: unwedge-stress
[232.913361] Starting dynamic subtest: render
[237.184521] Dynamic subtest render: SUCCESS (4.270s)
[237.200307] Starting dynamic subtest: bsd1
[255.360356] Dynamic subtest bsd1: SUCCESS (18.173s)
[255.376058] Starting dynamic subtest: bsd2
[273.357789] Dynamic subtest bsd2: SUCCESS (17.996s)
[273.373817] Starting dynamic subtest: blt
[273.375507] Dynamic subtest blt: SKIP (0.000s)
[273.383885] Starting dynamic subtest: vebox
[291.324995] Dynamic subtest vebox: SUCCESS (17.965s)
[291.326482] Subtest unwedge-stress: SUCCESS (58.409s)
[292.923391] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[292.926093] [042/133] (734s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[293.027535] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[293.029336] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[293.123618] [043/133] (734s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[293.207349] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[293.208255] Starting dynamic subtest: pipe-A-default-mode
[295.941761] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[295.942692] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.735s)
[296.775266] [044/133] (731s left) gem_exec_store (pages)
[296.842154] Starting subtest: pages
[296.843021] Starting dynamic subtest: rcs0
[296.927194] Dynamic subtest rcs0: SUCCESS (0.085s)
[296.937419] Starting dynamic subtest: bcs0
[296.995372] Dynamic subtest bcs0: SUCCESS (0.067s)
[297.006557] Starting dynamic subtest: vcs0
[297.077371] Dynamic subtest vcs0: SUCCESS (0.081s)
[297.090217] Starting dynamic subtest: vcs1
[297.155870] Dynamic subtest vcs1: SUCCESS (0.075s)
[297.171371] Starting dynamic subtest: vecs0
[297.226597] Dynamic subtest vecs0: SUCCESS (0.069s)
[297.237398] Starting dynamic subtest: ccs0
[297.294155] Dynamic subtest ccs0: SUCCESS (0.067s)
[297.295342] Subtest pages: SUCCESS (0.453s)
[297.470693] [045/133] (730s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[297.561358] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[297.563046] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[297.675703] [046/133] (730s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[297.763067] Starting subtest: psr-1p-primscrn-cur-indfb-move
[305.146919] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.384s)
[305.266875] [047/133] (722s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[305.362459] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[305.363353] Starting dynamic subtest: pipe-A-eDP-1
[305.371953] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[305.382371] Starting dynamic subtest: pipe-B-eDP-1
[305.390381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[305.399463] Starting dynamic subtest: pipe-C-eDP-1
[305.407080] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[305.415195] Starting dynamic subtest: pipe-D-eDP-1
[305.423595] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[305.425231] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[307.622348] [048/133] (720s left) kms_pm_rpm (basic-rte)
[307.655402] Starting subtest: basic-rte
[310.627973] Subtest basic-rte: SUCCESS (2.973s)
[312.437723] [049/133] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[312.530624] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[312.532490] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[312.628358] [050/133] (715s left) gem_exec_schedule (submit-golden-slice)
[312.696571] Starting subtest: submit-golden-slice
[312.697605] Starting dynamic subtest: rcs0
[312.734027] Dynamic subtest rcs0: SUCCESS (0.037s)
[312.744185] Starting dynamic subtest: bcs0
[312.778018] Dynamic subtest bcs0: SUCCESS (0.043s)
[312.786750] Starting dynamic subtest: vcs0
[312.810107] Dynamic subtest vcs0: SUCCESS (0.031s)
[312.822318] Starting dynamic subtest: vcs1
[312.843447] Dynamic subtest vcs1: SUCCESS (0.033s)
[312.852141] Starting dynamic subtest: vecs0
[312.877448] Dynamic subtest vecs0: SUCCESS (0.033s)
[312.886148] Starting dynamic subtest: ccs0
[312.916627] Dynamic subtest ccs0: SUCCESS (0.038s)
[312.917700] Subtest submit-golden-slice: SUCCESS (0.221s)
[313.959969] [051/133] (714s left) kms_async_flips (async-flip-hang)
[314.044454] Starting subtest: async-flip-hang
[314.422593] Starting dynamic subtest: pipe-A-eDP-1
[329.396158] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.969s)
[329.779736] Starting dynamic subtest: pipe-B-eDP-1
[345.392772] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.619s)
[345.784427] Starting dynamic subtest: pipe-C-eDP-1
[361.457752] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.674s)
[361.828276] Starting dynamic subtest: pipe-D-eDP-1
[377.390964] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.569s)
[377.392491] Subtest async-flip-hang: SUCCESS (63.345s)
[378.583842] [052/133] (649s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[378.791459] Starting subtest: cursor-rapid-movement-128x128
[378.794844] Starting dynamic subtest: pipe-A-eDP-1
[379.326421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[379.356066] Starting dynamic subtest: pipe-D-eDP-1
[380.504534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[380.505550] Subtest cursor-rapid-movement-128x128: SUCCESS (1.713s)
[381.357570] [053/133] (646s left) syncobj_timeline (invalid-query-bad-pad)
[381.407534] Starting subtest: invalid-query-bad-pad
[381.408424] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[381.495507] [054/133] (646s left) kms_tiled_display (basic-test-pattern)
[381.598888] Subtest basic-test-pattern: SKIP (0.000s)
[381.641644] [055/133] (646s left) perf (gen12-invalid-class-instance)
[381.732532] Starting subtest: gen12-invalid-class-instance
[381.743332] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[381.786448] [056/133] (646s left) kms_invalid_mode (uint-max-clock)
[381.871431] Starting subtest: uint-max-clock
[381.872373] Starting dynamic subtest: pipe-A-eDP-1
[382.161219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[382.169738] Starting dynamic subtest: pipe-B-eDP-1
[382.170624] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[382.178632] Starting dynamic subtest: pipe-C-eDP-1
[382.179514] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[382.187355] Starting dynamic subtest: pipe-D-eDP-1
[382.188264] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[382.189101] Subtest uint-max-clock: SUCCESS (0.294s)
[382.975740] [057/133] (645s left) kms_psr (fbc-psr-cursor-plane-move)
[383.067524] Starting subtest: fbc-psr-cursor-plane-move
[383.068340] Starting dynamic subtest: eDP-1
[383.069926] Dynamic subtest eDP-1: SKIP (0.000s)
[383.071708] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[383.143222] [058/133] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[383.229033] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[383.230957] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[383.328424] [059/133] (645s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[383.435130] Starting subtest: cursorB-vs-flipB-varying-size
[383.436728] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[383.587784] [060/133] (645s left) gem_exec_reloc (basic-gtt)
[383.635714] Subtest basic-gtt: SKIP (0.000s)
[383.698470] [061/133] (644s left) gem_lmem_swapping (basic)
[383.731456] Subtest basic: SKIP (0.000s)
[383.776322] [062/133] (644s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[383.893117] Starting subtest: basic-flip-before-cursor-varying-size
[384.837239] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.943s)
[385.704905] [063/133] (642s left) kms_cursor_crc (cursor-onscreen-512x512)
[385.976647] Starting subtest: cursor-onscreen-512x512
[385.978700] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[386.121698] [064/133] (642s left) gem_exec_params (larger-than-life-batch)
[386.171353] Starting subtest: larger-than-life-batch
[388.433872] Subtest larger-than-life-batch: SUCCESS (2.261s)
[388.942885] [065/133] (639s left) gem_close_race (multigpu-basic-process)
[389.048390] Starting subtest: multigpu-basic-process
[389.050300] Subtest multigpu-basic-process: SKIP (0.000s)
[389.293998] [066/133] (639s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[389.415667] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[390.903656] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.487s)
[391.772811] [067/133] (637s left) kms_feature_discovery (display-4x)
[391.877697] Starting subtest: display-4x
[391.879462] Subtest display-4x: SKIP (0.000s)
[391.950132] [068/133] (636s left) prime_mmap (test_refcounting)
[392.003072] Starting subtest: test_refcounting
[392.003947] Starting dynamic subtest: test_refcounting-smem
[392.038334] Dynamic subtest test_refcounting-smem: SUCCESS (0.036s)
[392.039529] Subtest test_refcounting: SUCCESS (0.037s)
[392.134525] [069/133] (636s left) kms_dp_aux_dev (basic)
[392.184435] Starting subtest: basic
[392.407870] Subtest basic: SUCCESS (0.222s)
[392.478386] [070/133] (636s left) syncobj_wait (invalid-reset-one-illegal-handle)
[392.549081] Starting subtest: invalid-reset-one-illegal-handle
[392.550211] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[392.642963] [071/133] (636s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[392.731795] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[392.733568] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[392.831302] [072/133] (636s left) gem_exec_reloc (basic-cpu)
[392.889423] Subtest basic-cpu: SKIP (0.000s)
[392.946204] [073/133] (636s left) gem_exec_balancer (sliced)
[393.010239] Starting subtest: sliced
[393.012286] Subtest sliced: SKIP (0.000s)
[393.291289] [074/133] (635s left) kms_plane_scaling (2x-scaler-multi-pipe)
[393.374316] Starting subtest: 2x-scaler-multi-pipe
[393.377054] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[393.499898] [075/133] (635s left) gem_ctx_persistence (engines-hang)
[393.557669] Starting subtest: engines-hang
[393.559080] Starting dynamic subtest: rcs0
[393.688210] Dynamic subtest rcs0: SUCCESS (0.130s)
[393.701789] Starting dynamic subtest: bcs0
[393.790640] Dynamic subtest bcs0: SUCCESS (0.100s)
[393.803308] Starting dynamic subtest: vcs0
[393.889369] Dynamic subtest vcs0: SUCCESS (0.097s)
[393.901834] Starting dynamic subtest: vcs1
[393.986301] Dynamic subtest vcs1: SUCCESS (0.095s)
[393.999594] Starting dynamic subtest: vecs0
[394.058352] Dynamic subtest vecs0: SUCCESS (0.070s)
[394.071884] Starting dynamic subtest: ccs0
[394.192587] Dynamic subtest ccs0: SUCCESS (0.132s)
[394.193802] Subtest engines-hang: SUCCESS (0.636s)
[394.267532] [076/133] (634s left) core_setmaster (master-drop-set-root)
[394.320533] Starting subtest: master-drop-set-root
[394.344390] Subtest master-drop-set-root: SUCCESS (0.024s)
[394.388030] [077/133] (634s left) gem_exec_flush (basic-uc-pro-default)
[394.452534] Starting subtest: basic-uc-pro-default
[399.924161] Subtest basic-uc-pro-default: SUCCESS (5.471s)
[400.105915] [078/133] (629s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[400.217465] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[400.219223] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[400.301325] [079/133] (628s left) gem_userptr_blits (forbidden-operations)
[400.375554] Starting subtest: forbidden-operations
[400.377489] Subtest forbidden-operations: SKIP (0.000s)
[400.543605] [080/133] (628s left) core_getclient (basic)
[400.585771] Starting subtest: basic
[400.587067] Subtest basic: SUCCESS (0.000s)
[400.669701] [081/133] (628s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[400.765936] Starting subtest: fbc-pr-sprite-mmap-gtt
[400.767725] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[400.848599] [082/133] (628s left) kms_flip (2x-plain-flip-fb-recreate)
[400.944643] Starting subtest: 2x-plain-flip-fb-recreate
[400.956360] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[401.032516] [083/133] (628s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[401.110152] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[401.112132] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[402.195674] [084/133] (627s left) syncobj_timeline (wait-all-delayed-signal)
[402.252579] Starting subtest: wait-all-delayed-signal
[402.356499] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[402.431193] [085/133] (627s left) gem_render_copy (linear-to-vebox-yf-tiled)
[402.483161] Starting subtest: linear-to-vebox-yf-tiled
[402.485414] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[402.655836] [086/133] (626s left) kms_cursor_crc (cursor-tearing-position-change)
[402.769274] Starting subtest: cursor-tearing-position-change
[402.770203] Starting dynamic subtest: pipe-A-eDP-1
[403.345492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[403.355275] Starting dynamic subtest: pipe-D-eDP-1
[404.553873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[404.554770] Subtest cursor-tearing-position-change: SUCCESS (1.785s)
[405.390282] [087/133] (624s left) syncobj_timeline (wait-for-submit-delayed-submit)
[405.441380] Starting subtest: wait-for-submit-delayed-submit
[405.545670] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[405.630897] [088/133] (623s left) gem_exec_params (invalid-ring)
[405.681087] Starting subtest: invalid-ring
[405.681927] Subtest invalid-ring: SUCCESS (0.000s)
[405.799018] [089/133] (623s left) gem_tiled_blits (interruptible)
[405.852781] Subtest interruptible: SKIP (0.000s)
[405.917980] [090/133] (623s left) gem_eio (banned)
[406.157659] Starting subtest: banned
[406.774797] Subtest banned: SUCCESS (0.619s)
[406.934923] [091/133] (622s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[407.019379] Starting subtest: plane-primary-overlay-mutable-zpos
[410.411978] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.390s)
[411.603426] [092/133] (618s left) kms_psr (fbc-pr-dpms)
[411.706652] Starting subtest: fbc-pr-dpms
[411.708504] Subtest fbc-pr-dpms: SKIP (0.000s)
[411.779274] [093/133] (618s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[411.865692] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[411.867371] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[411.935984] [094/133] (617s left) kms_plane_alpha_blend (alpha-transparent-fb)
[412.014451] Starting subtest: alpha-transparent-fb
[412.303037] Starting dynamic subtest: pipe-A-eDP-1
[412.925327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[412.936892] Starting dynamic subtest: pipe-D-eDP-1
[414.252844] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[414.253705] Subtest alpha-transparent-fb: SUCCESS (2.238s)
[415.084471] [095/133] (614s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[415.170362] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[415.171196] Starting dynamic subtest: pipe-A
[416.230107] Dynamic subtest pipe-A: SUCCESS (1.061s)
[416.240669] Starting dynamic subtest: pipe-B
[418.383052] Dynamic subtest pipe-B: SUCCESS (2.152s)
[418.392210] Starting dynamic subtest: pipe-C
[419.585187] Dynamic subtest pipe-C: SUCCESS (1.201s)
[419.595395] Starting dynamic subtest: pipe-D
[420.726086] Dynamic subtest pipe-D: SUCCESS (1.140s)
[420.728059] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.558s)
[421.925221] [096/133] (607s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[422.011505] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[422.012396] Starting dynamic subtest: pipe-A-eDP-1
[422.272439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.250s)
[422.283969] Starting dynamic subtest: pipe-B-eDP-1
[423.576769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s)
[423.586413] Starting dynamic subtest: pipe-C-eDP-1
[424.796675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[424.806490] Starting dynamic subtest: pipe-D-eDP-1
[426.005523] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[426.006404] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.983s)
[427.145608] [097/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[427.229632] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[427.231339] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[427.330671] [098/133] (602s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[427.429691] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[427.431483] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[427.498764] [099/133] (602s left) kms_flip (blocking-absolute-wf_vblank)
[427.590341] Starting subtest: blocking-absolute-wf_vblank
[427.591249] Starting dynamic subtest: A-eDP1
[436.335374] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[436.346651] Starting dynamic subtest: B-eDP1
[445.064218] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[445.075850] Starting dynamic subtest: C-eDP1
[453.805046] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[453.816307] Starting dynamic subtest: D-eDP1
[462.537524] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[462.538744] Subtest blocking-absolute-wf_vblank: SUCCESS (34.914s)
[463.704140] [100/133] (566s left) tools_test (sysfs_l3_parity)
[463.744223] Starting subtest: sysfs_l3_parity
[463.807632] Subtest sysfs_l3_parity: SKIP (0.069s)
[463.860232] [101/133] (566s left) kms_psr (psr-sprite-plane-onoff)
[463.943349] Starting subtest: psr-sprite-plane-onoff
[463.944216] Starting dynamic subtest: eDP-1
[465.768276] Dynamic subtest eDP-1: SUCCESS (1.824s)
[465.769266] Subtest psr-sprite-plane-onoff: SUCCESS (1.826s)
[466.585013] [102/133] (563s left) api_intel_allocator (default-alignment)
[466.644895] Starting subtest: default-alignment
[466.646551] Subtest default-alignment: SUCCESS (0.003s)
[466.767926] [103/133] (563s left) sriov_basic (bind-unbind-vf)
[466.829829] Starting subtest: bind-unbind-vf
[466.831269] Starting dynamic subtest: vf-1
[466.869253] Dynamic subtest vf-1: FAIL (0.022s)
[466.878855] Starting dynamic subtest: vf-2
[466.905946] Dynamic subtest vf-2: FAIL (0.004s)
[466.914967] Starting dynamic subtest: vf-3
[466.941130] Dynamic subtest vf-3: FAIL (0.004s)
[466.950142] Starting dynamic subtest: vf-4
[466.976354] Dynamic subtest vf-4: FAIL (0.004s)
[466.985039] Starting dynamic subtest: vf-5
[467.010846] Dynamic subtest vf-5: FAIL (0.004s)
[467.019295] Starting dynamic subtest: vf-6
[467.056081] Dynamic subtest vf-6: FAIL (0.004s)
[467.064823] Starting dynamic subtest: vf-7
[467.089603] Dynamic subtest vf-7: FAIL (0.004s)
[467.098046] Starting dynamic subtest: vf-random
[467.123440] Dynamic subtest vf-random: FAIL (0.004s)
[467.131963] Starting dynamic subtest: vf-last
[467.157691] Dynamic subtest vf-last: FAIL (0.004s)
[467.158490] Subtest bind-unbind-vf: FAIL (0.060s)
[467.191108] [104/133] (562s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[467.242251] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[467.346878] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[467.419518] [105/133] (562s left) perf_pmu (rc6)
[467.460771] Starting subtest: rc6
[467.461783] Starting dynamic subtest: gt0
[473.876623] Dynamic subtest gt0: SUCCESS (6.368s)
[473.888794] Starting dynamic subtest: runtime-pm-gt0
[481.617229] Dynamic subtest runtime-pm-gt0: SUCCESS (7.774s)
[481.629468] Starting dynamic subtest: runtime-pm-long-gt0
[494.101219] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.480s)
[494.113618] Starting dynamic subtest: other-idle-gt0
[500.445301] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[500.457533] Starting dynamic subtest: gt1
[506.788589] Dynamic subtest gt1: SUCCESS (6.341s)
[506.800874] Starting dynamic subtest: runtime-pm-gt1
[514.277220] Dynamic subtest runtime-pm-gt1: SUCCESS (7.488s)
[514.288794] Starting dynamic subtest: runtime-pm-long-gt1
[526.783199] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.503s)
[526.794977] Starting dynamic subtest: other-idle-gt1
[533.125198] Dynamic subtest other-idle-gt1: SUCCESS (6.339s)
[533.126130] Subtest rc6: SUCCESS (65.652s)
[533.743164] [106/133] (496s left) gem_exec_fence (syncobj-timeline-repeat)
[534.313444] Starting subtest: syncobj-timeline-repeat
[534.565851] Subtest syncobj-timeline-repeat: SUCCESS (0.253s)
[535.954305] [107/133] (494s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[536.049326] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[541.016840] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.968s)
[542.158240] [108/133] (488s left) kms_color (legacy-gamma-reset)
[542.241238] Starting subtest: legacy-gamma-reset
[542.242325] Starting dynamic subtest: pipe-A-eDP-1
[542.617868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.378s)
[542.626665] Starting dynamic subtest: pipe-B-eDP-1
[542.631564] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[542.640360] Starting dynamic subtest: pipe-C-eDP-1
[542.643575] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[542.652275] Starting dynamic subtest: pipe-D-eDP-1
[542.656649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[542.657547] Subtest legacy-gamma-reset: SUCCESS (0.418s)
[543.468809] [109/133] (486s left) gem_exec_balancer (indices)
[543.552838] Starting subtest: indices
[545.853018] Subtest indices: SUCCESS (2.290s)
[546.118014] [110/133] (484s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[546.167737] Starting subtest: yf-tiled-to-vebox-yf-tiled
[546.169417] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[546.323822] [111/133] (484s left) gem_barrier_race (remote-request)
[546.402174] Starting subtest: remote-request
[546.403050] Starting dynamic subtest: rcs0
[551.574482] Dynamic subtest rcs0: SUCCESS (5.172s)
[551.575393] Subtest remote-request: SUCCESS (5.173s)
[551.701838] [112/133] (478s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[551.758897] Starting subtest: etime-multi-wait-for-submit-submitted
[551.875080] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[551.918183] [113/133] (478s left) syncobj_timeline (multi-wait-signaled)
[551.965880] Starting subtest: multi-wait-signaled
[551.966879] Subtest multi-wait-signaled: SUCCESS (0.000s)
[552.027717] [114/133] (478s left) kms_chamelium_hpd (vga-hpd-fast)
[552.421916] Subtest vga-hpd-fast: SKIP (0.000s)
[553.196077] [115/133] (477s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[553.294346] Starting subtest: fbc-modesetfrombusy
[557.089217] Subtest fbc-modesetfrombusy: SUCCESS (3.795s)
[558.235765] [116/133] (472s left) kms_psr (psr-cursor-plane-onoff)
[558.333616] Starting subtest: psr-cursor-plane-onoff
[558.334602] Starting dynamic subtest: eDP-1
[560.057044] Dynamic subtest eDP-1: SUCCESS (1.723s)
[560.058199] Subtest psr-cursor-plane-onoff: SUCCESS (1.724s)
[560.895396] [117/133] (469s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[560.987335] Starting subtest: y-tiled-32bpp-rotate-90
[560.989059] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[561.051051] [118/133] (469s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[561.139267] Starting subtest: psr-rgb565-draw-mmap-gtt
[561.140856] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[561.196427] [119/133] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[561.282314] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[561.284268] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[561.363691] [120/133] (469s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[561.460422] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[561.461340] Starting dynamic subtest: pipe-A-eDP-1
[561.469021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[561.480400] Starting dynamic subtest: pipe-B-eDP-1
[561.487979] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[561.497541] Starting dynamic subtest: pipe-C-eDP-1
[561.504700] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[561.513586] Starting dynamic subtest: pipe-D-eDP-1
[561.520902] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[561.521747] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[563.774560] [121/133] (467s left) kms_plane_multiple (2x-tiling-none)
[563.863410] Starting subtest: 2x-tiling-none
[563.865057] Subtest 2x-tiling-none: SKIP (0.000s)
[563.907975] [122/133] (466s left) syncobj_wait (wait-any-interrupted)
[563.960091] Starting subtest: wait-any-interrupted
[564.062794] Subtest wait-any-interrupted: SUCCESS (0.102s)
[564.111415] [123/133] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[564.208254] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[564.209840] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[564.295162] [124/133] (466s left) i915_hangman (engine-error-state-capture)
[564.359108] Starting subtest: engine-error-state-capture
[564.360035] Starting dynamic subtest: rcs0
[567.869405] Dynamic subtest rcs0: SUCCESS (3.500s)
[567.879529] Starting dynamic subtest: bcs0
[573.886250] Dynamic subtest bcs0: SUCCESS (6.013s)
[573.898236] Starting dynamic subtest: vcs0
[579.900506] Dynamic subtest vcs0: SUCCESS (6.012s)
[579.914222] Starting dynamic subtest: vcs1
[584.893770] Dynamic subtest vcs1: SUCCESS (4.990s)
[584.905831] Starting dynamic subtest: vecs0
[590.844756] Dynamic subtest vecs0: SUCCESS (5.948s)
[590.856284] Starting dynamic subtest: ccs0
[596.861850] Dynamic subtest ccs0: SUCCESS (6.014s)
[596.863241] Subtest engine-error-state-capture: SUCCESS (32.494s)
[596.909902] [125/133] (434s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[597.009890] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[597.011519] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[597.093469] [126/133] (433s left) i915_drm_fdinfo (virtual-busy)
[597.128919] Starting subtest: virtual-busy
[597.131119] Subtest virtual-busy: SKIP (0.000s)
[597.166621] [127/133] (433s left) gem_ctx_param (invalid-param-set)
[597.226591] Starting subtest: invalid-param-set
[597.227626] Subtest invalid-param-set: SUCCESS (0.000s)
[597.276260] [128/133] (433s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[597.401343] Starting subtest: short-flip-after-cursor-atomic-transitions
[598.354418] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.953s)
[599.197846] [129/133] (431s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[599.258926] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[599.362911] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[599.412122] [130/133] (431s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[599.514230] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[599.516537] Starting dynamic subtest: pipe-A-eDP-1
[599.637904] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[599.650539] Starting dynamic subtest: pipe-B-eDP-1
[600.799197] Dynamic subtest pipe-B-eDP-1: SKIP (1.160s)
[600.800940] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.286s)
[601.959731] [131/133] (429s left) i915_query (query-regions-sanity-check)
[602.018307] Starting subtest: query-regions-sanity-check
[602.030024] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[602.118296] [132/133] (429s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[602.225237] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[608.750441] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.526s)
[608.836728] [133/133] (422s left) gem_mmap_gtt (ptrace)
[608.888119] Subtest ptrace: SKIP (0.000s)
[608.941803] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_async
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_chamelium_frames
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_busy
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_tiled_swapping
results: parsing output: 9/ for test: kms_legacy_colorkey
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_partial_pwrite_pread
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_exec_store
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_close_race
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_feature_discovery
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_dp_aux_dev
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: core_setmaster
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: core_getclient
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: gem_tiled_blits
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: tools_test
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: api_intel_allocator
results: parsing output: 102/ for test: sriov_basic
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: gem_barrier_race
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: i915_query
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
Done.