[58.716461] Initializing watchdogs
[58.716507]   /dev/watchdog0
[58.731425] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.735628] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.737951] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.741686] [001/156] (960s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[58.896585] Starting subtest: verify-pxp-key-change-after-suspend-resume
[66.928300] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.106s)
[68.046641] [002/156] (952s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[68.154188] Starting subtest: psr-dirtyfb-ioctl
[68.156498] Starting dynamic subtest: A-eDP-1
[72.093958] Dynamic subtest A-eDP-1: SUCCESS (3.948s)
[72.096450] Subtest psr-dirtyfb-ioctl: SUCCESS (3.949s)
[73.004017] [003/156] (947s left) gem_userptr_blits (sync-overlap)
[73.115114] Starting subtest: sync-overlap
[73.117450] Subtest sync-overlap: SUCCESS (0.000s)
[73.325218] [004/156] (947s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[73.428109] Starting subtest: single-wait-all-for-submit-signaled
[73.430801] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[73.530287] [005/156] (946s left) syncobj_timeline (etime-single-wait-all-submitted)
[73.581868] Starting subtest: etime-single-wait-all-submitted
[73.687788] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[73.772558] [006/156] (946s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[73.877536] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[73.882204] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[73.962061] [007/156] (946s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[74.063050] Starting subtest: y-tiled-8bpp-rotate-90
[74.067199] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[74.157941] [008/156] (946s left) kms_cursor_crc (cursor-onscreen-128x42)
[74.407163] Starting subtest: cursor-onscreen-128x42
[74.459388] Subtest cursor-onscreen-128x42: SKIP (0.046s)
[74.656901] [009/156] (945s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[74.766846] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[74.770527] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[74.863258] [010/156] (945s left) drm_read (invalid-buffer)
[75.031371] Starting subtest: invalid-buffer
[75.033451] Subtest invalid-buffer: SUCCESS (0.000s)
[75.176493] [011/156] (945s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[75.272492] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[75.275907] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[75.362111] [012/156] (945s left) gem_pxp (create-valid-protected-context)
[75.409724] Starting subtest: create-valid-protected-context
[75.411548] Subtest create-valid-protected-context: SUCCESS (0.001s)
[75.519026] [013/156] (945s left) kms_flip (2x-nonexisting-fb)
[75.612592] Starting subtest: 2x-nonexisting-fb
[75.621786] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[75.712088] [014/156] (945s left) gem_exec_reloc (basic-wc-read)
[75.766691] Subtest basic-wc-read: SKIP (0.000s)
[75.827342] [015/156] (944s left) kms_vblank (query-forked-hang)
[75.916933] Starting subtest: query-forked-hang
[75.918516] Starting dynamic subtest: pipe-A-eDP-1
[102.078774] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.174s)
[102.092278] Starting dynamic subtest: pipe-D-eDP-1
[117.047163] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.971s)
[117.049674] Subtest query-forked-hang: SUCCESS (41.148s)
[117.921561] [016/156] (902s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[118.010550] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[118.015620] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[118.107717] [017/156] (902s left) gem_exec_params (rsvd2-dirt)
[118.167944] Starting subtest: rsvd2-dirt
[118.172609] Subtest rsvd2-dirt: SKIP (0.000s)
[118.267306] [018/156] (902s left) core_setmaster (master-drop-set-root)
[118.320740] Starting subtest: master-drop-set-root
[118.337824] Subtest master-drop-set-root: SUCCESS (0.016s)
[118.390371] [019/156] (902s left) gem_ctx_persistence (engines-mixed-process)
[118.448467] Starting subtest: engines-mixed-process
[118.450640] Starting dynamic subtest: rcs0
[120.331370] Dynamic subtest rcs0: SUCCESS (1.885s)
[120.340262] Starting dynamic subtest: bcs0
[122.282853] Dynamic subtest bcs0: SUCCESS (1.951s)
[122.291702] Starting dynamic subtest: vcs0
[124.288809] Dynamic subtest vcs0: SUCCESS (2.006s)
[124.299929] Starting dynamic subtest: vcs1
[126.275835] Dynamic subtest vcs1: SUCCESS (1.986s)
[126.286653] Starting dynamic subtest: vecs0
[128.326874] Dynamic subtest vecs0: SUCCESS (2.050s)
[128.337809] Starting dynamic subtest: ccs0
[130.313414] Dynamic subtest ccs0: SUCCESS (1.986s)
[130.316167] Subtest engines-mixed-process: SUCCESS (11.869s)
[130.404209] [020/156] (890s left) gem_exec_reloc (basic-cpu-wc-active)
[130.464311] Subtest basic-cpu-wc-active: SKIP (0.000s)
[130.532789] [021/156] (890s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[130.641500] Starting subtest: 4-tiled-8bpp-rotate-270
[130.663269] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[130.775235] [022/156] (890s left) gen7_exec_parse (load-register-reg)
[130.835271] Subtest load-register-reg: SKIP (0.000s)
[130.900168] [023/156] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[130.998727] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[138.482940] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.491s)
[138.609289] [024/156] (882s left) gem_pwrite_snooped
[138.744997] [025/156] (882s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[138.828781] Starting subtest: plane-upscale-20x20-with-pixel-format
[138.831110] Starting dynamic subtest: pipe-A
[139.886343] Dynamic subtest pipe-A: SUCCESS (1.060s)
[139.896903] Starting dynamic subtest: pipe-B
[142.037175] Dynamic subtest pipe-B: SUCCESS (2.151s)
[142.049171] Starting dynamic subtest: pipe-C
[143.229401] Dynamic subtest pipe-C: SUCCESS (1.191s)
[143.239859] Starting dynamic subtest: pipe-D
[144.463079] Dynamic subtest pipe-D: SUCCESS (1.233s)
[144.465302] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.637s)
[145.645591] [026/156] (875s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[145.742432] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[155.171644] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.435s)
[155.284950] [027/156] (866s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[155.392750] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[156.227766] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[156.398304] [028/156] (864s left) gem_mmap_offset (basic-uaf)
[156.457687] Starting subtest: basic-uaf
[156.459894] Subtest basic-uaf: SUCCESS (0.001s)
[156.553161] [029/156] (864s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[156.654879] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[156.659473] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[156.746075] [030/156] (864s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[156.834906] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[156.839312] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[156.924749] [031/156] (864s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[157.024121] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[157.028347] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[157.132139] [032/156] (864s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[157.230817] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[158.078041] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[158.239360] [033/156] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[158.333574] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[162.769734] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.444s)
[163.924975] [034/156] (857s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[164.035148] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[164.039247] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[164.111840] [035/156] (857s left) syncobj_wait (invalid-reset-one-illegal-handle)
[164.163367] Starting subtest: invalid-reset-one-illegal-handle
[164.165716] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[164.257134] [036/156] (857s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[164.347289] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[164.351258] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[164.453856] [037/156] (857s left) syncobj_wait (multi-wait-for-submit-submitted)
[164.502949] Starting subtest: multi-wait-for-submit-submitted
[164.607087] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[164.680111] [038/156] (857s left) kms_dsc (dsc-with-formats)
[164.759554] Starting subtest: dsc-with-formats
[164.800890] Subtest dsc-with-formats: SKIP (0.001s)
[164.839144] [039/156] (856s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[164.940754] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[164.944946] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[165.045205] [040/156] (856s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[165.140747] Starting subtest: read-crc-frame-sequence
[165.143073] Starting dynamic subtest: pipe-A-eDP-1
[165.856777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[165.868114] Starting dynamic subtest: pipe-B-eDP-1
[167.286627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[167.296843] Starting dynamic subtest: pipe-C-eDP-1
[168.684028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[168.694566] Starting dynamic subtest: pipe-D-eDP-1
[170.000822] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[170.003237] Subtest read-crc-frame-sequence: SUCCESS (4.861s)
[170.854510] [041/156] (850s left) prime_vgem (sync)
[170.979669] Starting subtest: sync
[170.981885] Starting dynamic subtest: rcs0
[171.017353] Dynamic subtest rcs0: SUCCESS (0.037s)
[171.027084] Starting dynamic subtest: bcs0
[171.081507] Dynamic subtest bcs0: SUCCESS (0.063s)
[171.090129] Starting dynamic subtest: vcs0
[171.129740] Dynamic subtest vcs0: SUCCESS (0.048s)
[171.138323] Starting dynamic subtest: vcs1
[171.174184] Dynamic subtest vcs1: SUCCESS (0.044s)
[171.183068] Starting dynamic subtest: vecs0
[171.218330] Dynamic subtest vecs0: SUCCESS (0.043s)
[171.227069] Starting dynamic subtest: ccs0
[171.265293] Dynamic subtest ccs0: SUCCESS (0.046s)
[171.267456] Subtest sync: SUCCESS (0.286s)
[171.384740] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[171.388115] [042/156] (850s left) kms_psr (fbc-psr2-cursor-plane-move)
[171.475945] Starting subtest: fbc-psr2-cursor-plane-move
[171.478261] Starting dynamic subtest: eDP-1
[171.482458] Dynamic subtest eDP-1: SKIP (0.000s)
[171.486678] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[171.546621] [043/156] (850s left) prime_self_import (basic-with_one_bo_two_files)
[171.581473] Starting subtest: basic-with_one_bo_two_files
[171.594227] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[171.702296] [044/156] (850s left) kms_busy (basic)
[171.794425] Starting subtest: basic
[171.796376] Starting dynamic subtest: flip
[173.189099] Dynamic subtest flip: SUCCESS (1.392s)
[173.200271] Starting dynamic subtest: modeset
[176.403853] Dynamic subtest modeset: SUCCESS (3.216s)
[176.406562] Subtest basic: SUCCESS (4.611s)
[177.231301] [045/156] (844s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[177.330987] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[177.335232] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[177.425739] [046/156] (844s left) gem_render_copy (y-tiled-ccs-to-linear)
[177.478869] Starting subtest: y-tiled-ccs-to-linear
[177.483308] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[177.673484] [047/156] (844s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[177.771173] Starting subtest: psr-rgb101010-draw-render
[185.025561] Subtest psr-rgb101010-draw-render: SUCCESS (7.261s)
[185.163226] [048/156] (836s left) perf (create-destroy-userspace-config)
[185.292364] Starting subtest: create-destroy-userspace-config
[185.310173] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[185.356372] [049/156] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[185.459668] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[185.463894] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[185.559259] [050/156] (836s left) kms_psr (fbc-psr-basic)
[185.648284] Starting subtest: fbc-psr-basic
[185.650188] Starting dynamic subtest: eDP-1
[185.654293] Dynamic subtest eDP-1: SKIP (0.000s)
[185.658365] Subtest fbc-psr-basic: SKIP (0.001s)
[185.730100] [051/156] (836s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[185.827954] Starting subtest: pr-cursor-plane-move-continuous-sf
[185.832037] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[185.901746] [052/156] (836s left) kms_lease (lease-get)
[185.996526] Starting subtest: lease-get
[185.998505] Starting dynamic subtest: pipe-A-eDP-1
[186.000492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[186.010144] Starting dynamic subtest: pipe-B-eDP-1
[186.011775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[186.020499] Starting dynamic subtest: pipe-C-eDP-1
[186.022089] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[186.030306] Starting dynamic subtest: pipe-D-eDP-1
[186.031908] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[186.033535] Subtest lease-get: SUCCESS (0.008s)
[186.103774] [053/156] (836s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[186.188049] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[186.191481] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[186.277558] [054/156] (836s left) perf (missing-sample-flags)
[186.377589] Starting subtest: missing-sample-flags
[186.379678] Subtest missing-sample-flags: SUCCESS (0.001s)
[186.418107] [055/156] (835s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[186.505996] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[186.509490] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[186.581236] [056/156] (835s left) gem_ctx_persistence (heartbeat-close)
[186.647968] Starting subtest: heartbeat-close
[186.651571] Subtest heartbeat-close: SKIP (0.000s)
[186.750865] [057/156] (835s left) kms_psr (psr2-sprite-blt)
[186.839700] Starting subtest: psr2-sprite-blt
[186.841723] Starting dynamic subtest: eDP-1
[188.531153] Dynamic subtest eDP-1: SUCCESS (1.690s)
[188.533465] Subtest psr2-sprite-blt: SUCCESS (1.691s)
[189.393664] [058/156] (833s left) kms_color (ctm-green-to-red)
[189.496907] Starting subtest: ctm-green-to-red
[189.499213] Starting dynamic subtest: pipe-A-eDP-1
[190.214228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[190.225532] Starting dynamic subtest: pipe-B-eDP-1
[191.584586] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[191.594771] Starting dynamic subtest: pipe-C-eDP-1
[192.947863] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[192.958177] Starting dynamic subtest: pipe-D-eDP-1
[194.316421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.368s)
[194.318400] Subtest ctm-green-to-red: SUCCESS (4.820s)
[195.127067] [059/156] (827s left) i915_drm_fdinfo (most-busy-check-all)
[195.170118] Starting subtest: most-busy-check-all
[195.172308] Starting dynamic subtest: rcs0
[195.176692] Dynamic subtest rcs0: SKIP (0.004s)
[195.185664] Starting dynamic subtest: bcs0
[195.189718] Dynamic subtest bcs0: SKIP (0.000s)
[195.198344] Starting dynamic subtest: vcs0
[195.202950] Dynamic subtest vcs0: SKIP (0.000s)
[195.211966] Starting dynamic subtest: vcs1
[195.216428] Dynamic subtest vcs1: SKIP (0.000s)
[195.225216] Starting dynamic subtest: vecs0
[195.229656] Dynamic subtest vecs0: SKIP (0.000s)
[195.238376] Starting dynamic subtest: ccs0
[195.242897] Dynamic subtest ccs0: SKIP (0.000s)
[195.247364] Subtest most-busy-check-all: SKIP (0.008s)
[195.286482] [060/156] (827s left) i915_hangman (gt-error-state-capture)
[195.339503] Starting subtest: gt-error-state-capture
[195.341792] Starting dynamic subtest: rcs0
[207.258304] Dynamic subtest rcs0: SUCCESS (11.918s)
[207.271212] Starting dynamic subtest: bcs0
[219.226485] Dynamic subtest bcs0: SUCCESS (11.967s)
[219.238860] Starting dynamic subtest: vcs0
[231.193829] Dynamic subtest vcs0: SUCCESS (11.964s)
[231.206999] Starting dynamic subtest: vcs1
[242.200792] Dynamic subtest vcs1: SUCCESS (11.002s)
[242.220624] Starting dynamic subtest: vecs0
[253.209914] Dynamic subtest vecs0: SUCCESS (11.005s)
[253.223339] Starting dynamic subtest: ccs0
[264.281644] Dynamic subtest ccs0: SUCCESS (11.068s)
[264.284596] Subtest gt-error-state-capture: SUCCESS (68.939s)
[264.421168] [061/156] (758s left) kms_plane_scaling (planes-downscale-factor-0-75)
[264.523067] Starting subtest: planes-downscale-factor-0-75
[264.525414] Starting dynamic subtest: pipe-A
[264.545540] Dynamic subtest pipe-A: SKIP (0.019s)
[264.555191] Starting dynamic subtest: pipe-B
[264.578759] Dynamic subtest pipe-B: SKIP (0.033s)
[264.588131] Starting dynamic subtest: pipe-C
[264.615013] Dynamic subtest pipe-C: SKIP (0.034s)
[264.624464] Starting dynamic subtest: pipe-D
[264.650835] Dynamic subtest pipe-D: SKIP (0.035s)
[264.654949] Subtest planes-downscale-factor-0-75: SKIP (0.123s)
[264.753604] [062/156] (757s left) gem_exec_schedule (u-fairslice-all)
[264.828691] Starting subtest: u-fairslice-all
[266.884405] Subtest u-fairslice-all: SUCCESS (2.060s)
[267.177138] [063/156] (755s left) gem_exec_whisper (basic-sync)
[267.233712] Starting subtest: basic-sync
[277.806285] Subtest basic-sync: SUCCESS (10.569s)
[277.992732] [064/156] (744s left) perf (blocking)
[278.075920] Starting subtest: blocking
[278.078331] Starting dynamic subtest: 0-rcs0
[288.093261] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[288.105877] Starting dynamic subtest: 1-vcs1
[298.115069] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[298.117811] Subtest blocking: SUCCESS (20.037s)
[298.166456] [065/156] (724s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[298.271323] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[298.275309] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[298.383736] [066/156] (724s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[298.477864] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[298.482169] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[298.547496] [067/156] (724s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[298.646071] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[298.650628] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[298.762260] [068/156] (724s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[298.860607] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[298.864591] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[298.959481] [069/156] (724s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt)
[299.057789] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt
[299.061933] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[299.142188] [070/156] (723s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[299.285317] Starting subtest: dp-mst-type-0-suspend-resume
[299.289071] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[299.407664] [071/156] (723s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[299.506518] Starting subtest: pixel-format-linear-modifier-source-clamping
[299.532682] Starting dynamic subtest: pipe-A-plane-0
[300.121156] Dynamic subtest pipe-A-plane-0: SUCCESS (0.588s)
[300.130494] Starting dynamic subtest: pipe-A-plane-3
[300.587761] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[301.708394] Starting dynamic subtest: pipe-B-plane-0
[302.289357] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[302.300477] Starting dynamic subtest: pipe-B-plane-3
[302.721723] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[303.048848] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.541s)
[303.880413] [072/156] (719s left) gem_exec_create (basic)
[303.949622] Starting subtest: basic
[303.951978] Starting dynamic subtest: smem
[307.258694] Dynamic subtest smem: SUCCESS (3.307s)
[307.261790] Subtest basic: SUCCESS (3.309s)
[307.443256] [073/156] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[307.556605] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[311.954852] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.404s)
[313.181273] [074/156] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[313.279938] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[320.012206] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.739s)
[320.146663] [075/156] (703s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[320.252996] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[320.255265] Starting dynamic subtest: pipe-A-eDP-1
[320.277366] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[320.287713] Starting dynamic subtest: pipe-B-eDP-1
[320.309155] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[320.318179] Starting dynamic subtest: pipe-C-eDP-1
[320.339744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[320.348956] Starting dynamic subtest: pipe-D-eDP-1
[320.371092] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[320.375427] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[322.553908] [076/156] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[322.662388] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[329.975284] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.318s)
[330.099678] [077/156] (693s left) kms_chamelium_hpd (vga-hpd)
[330.490640] Subtest vga-hpd: SKIP (0.000s)
[331.265103] [078/156] (692s left) gem_eio (in-flight-contexts-1us)
[331.502861] Starting subtest: in-flight-contexts-1us
[343.328384] Subtest in-flight-contexts-1us: SUCCESS (11.824s)
[343.501266] [079/156] (679s left) kms_vblank (ts-continuation-dpms-rpm)
[343.598341] Starting subtest: ts-continuation-dpms-rpm
[343.600589] Starting dynamic subtest: pipe-A-eDP-1
[346.080799] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.484s)
[346.096641] Starting dynamic subtest: pipe-D-eDP-1
[348.333878] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[348.336153] Subtest ts-continuation-dpms-rpm: SUCCESS (4.736s)
[349.223056] [080/156] (674s left) vgem_basic (unload)
[349.268031] Starting subtest: unload
[378.327664] Subtest unload: SUCCESS (29.061s)
[378.439104] [081/156] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[378.530183] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[385.648198] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.122s)
[385.784230] [082/156] (637s left) kms_async_flips (async-flip-suspend-resume)
[385.876032] Starting subtest: async-flip-suspend-resume
[386.259808] Starting dynamic subtest: pipe-A-eDP-1
[403.994336] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.902s)
[404.360735] Starting dynamic subtest: pipe-B-eDP-1
[421.996302] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.940s)
[422.369894] Starting dynamic subtest: pipe-C-eDP-1
[440.000081] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.965s)
[440.357983] Starting dynamic subtest: pipe-D-eDP-1
[458.002260] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.975s)
[458.004533] Subtest async-flip-suspend-resume: SUCCESS (13.265s)
[459.179663] [083/156] (564s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[459.287685] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[459.291943] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[459.377257] [084/156] (564s left) kms_cursor_crc (cursor-sliding-32x32)
[459.509457] Starting subtest: cursor-sliding-32x32
[459.554635] Subtest cursor-sliding-32x32: SKIP (0.041s)
[459.811364] [085/156] (563s left) i915_query (query-topology-kernel-writes)
[459.865757] Starting subtest: query-topology-kernel-writes
[459.868009] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[459.972303] [086/156] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[460.061667] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[460.064980] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[460.150611] [087/156] (563s left) gem_exec_fence (concurrent)
[460.317022] Starting subtest: concurrent
[460.321584] Subtest concurrent: SKIP (0.000s)
[461.516056] [088/156] (562s left) kms_flip (wf_vblank-ts-check-interruptible)
[461.607650] Starting subtest: wf_vblank-ts-check-interruptible
[461.609887] Starting dynamic subtest: A-eDP1
[482.310105] Dynamic subtest A-eDP1: SUCCESS (20.871s)
[482.320260] Starting dynamic subtest: B-eDP1
[491.234336] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[491.252194] Starting dynamic subtest: C-eDP1
[500.168232] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[500.180613] Starting dynamic subtest: D-eDP1
[509.101908] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[509.107044] Subtest wf_vblank-ts-check-interruptible: SUCCESS (47.662s)
[510.334646] [089/156] (513s left) kms_addfb_basic (invalid-get-prop-any)
[510.396643] Starting subtest: invalid-get-prop-any
[510.398797] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[510.523561] [090/156] (513s left) gem_ctx_shared (exec-single-timeline)
[510.591827] Starting subtest: exec-single-timeline
[510.594910] Starting dynamic subtest: rcs0
[511.633204] Dynamic subtest rcs0: SUCCESS (1.039s)
[511.648365] Starting dynamic subtest: bcs0
[512.721544] Dynamic subtest bcs0: SUCCESS (1.084s)
[512.733604] Starting dynamic subtest: vcs0
[513.813201] Dynamic subtest vcs0: SUCCESS (1.087s)
[513.827522] Starting dynamic subtest: vcs1
[514.898115] Dynamic subtest vcs1: SUCCESS (1.082s)
[514.911648] Starting dynamic subtest: vecs0
[515.985615] Dynamic subtest vecs0: SUCCESS (1.085s)
[516.005607] Starting dynamic subtest: ccs0
[517.074328] Dynamic subtest ccs0: SUCCESS (1.084s)
[517.077876] Subtest exec-single-timeline: SUCCESS (6.482s)
[517.280769] [091/156] (506s left) gem_spin_batch (legacy)
[517.343962] Starting subtest: legacy
[517.346341] Starting dynamic subtest: default
[520.582553] Dynamic subtest default: SUCCESS (3.237s)
[520.593962] Starting dynamic subtest: render
[523.814897] Dynamic subtest render: SUCCESS (3.229s)
[523.825540] Starting dynamic subtest: bsd
[527.051920] Dynamic subtest bsd: SUCCESS (3.234s)
[527.062277] Starting dynamic subtest: bsd1
[530.285482] Dynamic subtest bsd1: SUCCESS (3.230s)
[530.297948] Starting dynamic subtest: bsd2
[533.523374] Dynamic subtest bsd2: SUCCESS (3.235s)
[533.536371] Starting dynamic subtest: blt
[536.762518] Dynamic subtest blt: SUCCESS (3.237s)
[536.773751] Starting dynamic subtest: vebox
[540.001955] Dynamic subtest vebox: SUCCESS (3.237s)
[540.004152] Subtest legacy: SUCCESS (22.662s)
[540.456887] [092/156] (483s left) gem_mmap_gtt (close-race)
[540.515222] Subtest close-race: SKIP (0.000s)
[540.581814] [093/156] (483s left) gem_exec_reloc (basic-write-read-active)
[540.640383] Subtest basic-write-read-active: SKIP (0.000s)
[540.718256] [094/156] (483s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[540.817826] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[540.822330] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[540.926834] [095/156] (483s left) perf_pmu (busy-accuracy-98)
[540.965746] Starting subtest: busy-accuracy-98
[540.968032] Starting dynamic subtest: rcs0
[544.000586] Dynamic subtest rcs0: SUCCESS (3.035s)
[544.013538] Starting dynamic subtest: bcs0
[547.048613] Dynamic subtest bcs0: SUCCESS (3.048s)
[547.061755] Starting dynamic subtest: vcs0
[550.096316] Dynamic subtest vcs0: SUCCESS (3.046s)
[550.107767] Starting dynamic subtest: vcs1
[553.137639] Dynamic subtest vcs1: SUCCESS (3.039s)
[553.150309] Starting dynamic subtest: vecs0
[556.181241] Dynamic subtest vecs0: SUCCESS (3.039s)
[556.193843] Starting dynamic subtest: ccs0
[559.229590] Dynamic subtest ccs0: SUCCESS (3.045s)
[559.232046] Subtest busy-accuracy-98: SUCCESS (18.266s)
[559.345500] [096/156] (464s left) gem_create (create-ext-cpu-access-big)
[559.510951] Starting subtest: create-ext-cpu-access-big
[559.515839] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[559.587331] [097/156] (464s left) kms_psr (psr-sprite-blt)
[559.683342] Starting subtest: psr-sprite-blt
[559.685922] Starting dynamic subtest: eDP-1
[561.422010] Dynamic subtest eDP-1: SUCCESS (1.738s)
[561.424381] Subtest psr-sprite-blt: SUCCESS (1.739s)
[562.285484] [098/156] (461s left) core_auth (basic-auth)
[562.341846] Starting subtest: basic-auth
[562.344524] Subtest basic-auth: SUCCESS (0.001s)
[562.436465] [099/156] (461s left) kms_chamelium_frames (hdmi-crc-multiple)
[562.815660] Subtest hdmi-crc-multiple: SKIP (0.000s)
[563.598417] [100/156] (460s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[563.698440] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[563.702458] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[563.810654] [101/156] (460s left) gem_exec_balancer (parallel-balancer)
[564.065643] Starting subtest: parallel-balancer
[564.993861] Subtest parallel-balancer: SUCCESS (0.928s)
[565.122476] [102/156] (459s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff)
[565.223267] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff
[565.227883] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[565.325655] [103/156] (459s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[565.423324] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[565.425608] Starting dynamic subtest: pipe-A-default-mode
[568.173291] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[568.175698] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.752s)
[569.050995] [104/156] (455s left) kms_psr (pr-primary-page-flip)
[569.143543] Starting subtest: pr-primary-page-flip
[569.147604] Subtest pr-primary-page-flip: SKIP (0.000s)
[569.215119] [105/156] (455s left) gem_mmap_gtt (basic-read)
[569.264393] Subtest basic-read: SKIP (0.000s)
[569.327267] [106/156] (455s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[569.434687] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[569.438895] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[569.538902] [107/156] (455s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[569.637402] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[569.639613] Starting dynamic subtest: pipe-A-eDP-1
[569.662320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.674843] Starting dynamic subtest: pipe-B-eDP-1
[569.696979] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.707070] Starting dynamic subtest: pipe-C-eDP-1
[569.728706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.738447] Starting dynamic subtest: pipe-D-eDP-1
[569.763361] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.767739] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[571.899824] [108/156] (452s left) kms_invalid_mode (bad-vsync-end)
[571.996245] Starting subtest: bad-vsync-end
[571.998491] Starting dynamic subtest: pipe-A-eDP-1
[572.283882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[572.295578] Starting dynamic subtest: pipe-B-eDP-1
[572.297889] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[572.308452] Starting dynamic subtest: pipe-C-eDP-1
[572.310376] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[572.319674] Starting dynamic subtest: pipe-D-eDP-1
[572.321640] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[572.323692] Subtest bad-vsync-end: SUCCESS (0.296s)
[573.123866] [109/156] (451s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[573.228615] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[573.232871] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[573.329676] [110/156] (451s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[573.425056] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[577.701044] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.282s)
[578.933584] [111/156] (445s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[579.032265] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[579.036821] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[579.128506] [112/156] (445s left) gem_partial_pwrite_pread (writes-after-reads-display)
[579.182422] Subtest writes-after-reads-display: SKIP (0.000s)
[579.254444] [113/156] (445s left) api_intel_bb (intel-bb-blit-none)
[579.310336] Starting subtest: intel-bb-blit-none
[583.277930] Subtest intel-bb-blit-none: SUCCESS (3.969s)
[583.387871] [114/156] (441s left) gem_exec_schedule (preemptive-hang)
[583.573127] Starting subtest: preemptive-hang
[583.575998] Starting dynamic subtest: rcs0
[592.612227] Dynamic subtest rcs0: SUCCESS (9.037s)
[592.624073] Starting dynamic subtest: bcs0
[601.564494] Dynamic subtest bcs0: SUCCESS (8.953s)
[601.574549] Starting dynamic subtest: vcs0
[610.526193] Dynamic subtest vcs0: SUCCESS (8.957s)
[610.538807] Starting dynamic subtest: vcs1
[619.545904] Dynamic subtest vcs1: SUCCESS (9.022s)
[619.560000] Starting dynamic subtest: vecs0
[628.510501] Dynamic subtest vecs0: SUCCESS (8.964s)
[628.520654] Starting dynamic subtest: ccs0
[637.537864] Dynamic subtest ccs0: SUCCESS (9.027s)
[637.540223] Subtest preemptive-hang: SUCCESS (53.969s)
[637.800858] [115/156] (387s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[637.851838] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[637.854253] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[637.980116] [116/156] (387s left) kms_atomic (test-only)
[638.076552] Starting subtest: test-only
[638.121498] Starting dynamic subtest: pipe-A-eDP-1
[640.638965] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.515s)
[640.641211] Subtest test-only: SUCCESS (2.563s)
[641.527322] [117/156] (383s left) gem_exec_params (invalid-batch-start-offset)
[641.583759] Starting subtest: invalid-batch-start-offset
[641.586312] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[641.703822] [118/156] (383s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[641.799244] Starting subtest: plane-all-transition-nonblocking-fencing
[641.801405] Starting dynamic subtest: pipe-A-eDP-1
[644.293065] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[644.612202] Starting dynamic subtest: pipe-B-eDP-1
[647.867973] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.267s)
[648.167422] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.370s)
[648.982575] [119/156] (376s left) gem_mmap_gtt (basic-small-bo-tiledy)
[649.039270] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[649.099343] [120/156] (376s left) gem_bad_reloc (negative-reloc)
[649.152862] Subtest negative-reloc: SKIP (0.000s)
[649.218668] [121/156] (375s left) gem_userptr_blits (create-destroy-unsync)
[649.286942] Subtest create-destroy-unsync: SKIP (0.000s)
[649.397077] [122/156] (375s left) gem_render_copy (y-tiled-to-vebox-linear)
[649.449996] Starting subtest: y-tiled-to-vebox-linear
[649.453937] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[649.631621] [123/156] (375s left) api_intel_bb (blit-noreloc-keep-cache)
[649.679452] Starting subtest: blit-noreloc-keep-cache
[649.687562] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[649.811784] [124/156] (375s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[649.913823] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[649.918188] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[650.017076] [125/156] (375s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[650.101882] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[650.104244] Starting dynamic subtest: pipe-A-eDP-1
[650.127017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[650.139572] Starting dynamic subtest: pipe-B-eDP-1
[650.160230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[650.170055] Starting dynamic subtest: pipe-C-eDP-1
[650.191352] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[650.202796] Starting dynamic subtest: pipe-D-eDP-1
[650.223753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[650.228958] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[652.349114] [126/156] (373s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[652.450577] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[652.452919] Starting dynamic subtest: pipe-A-eDP-1
[652.480440] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[652.491829] Starting dynamic subtest: pipe-B-eDP-1
[652.515775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[652.525499] Starting dynamic subtest: pipe-C-eDP-1
[652.549625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[652.559364] Starting dynamic subtest: pipe-D-eDP-1
[652.585240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[652.589606] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[654.717083] [127/156] (370s left) kms_rmfb (close-fd)
[654.803464] Starting subtest: close-fd
[654.805738] Starting dynamic subtest: pipe-A-eDP-1
[654.909518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[654.929125] Starting dynamic subtest: pipe-B-eDP-1
[656.085706] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[656.098652] Starting dynamic subtest: pipe-C-eDP-1
[657.300516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[657.310815] Starting dynamic subtest: pipe-D-eDP-1
[658.436240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[658.438564] Subtest close-fd: SUCCESS (3.635s)
[659.643775] [128/156] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[659.733966] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[659.737893] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[659.818861] [129/156] (365s left) kms_cursor_crc (cursor-random-max-size)
[660.128256] Starting subtest: cursor-random-max-size
[660.134929] Subtest cursor-random-max-size: SKIP (0.000s)
[660.273024] [130/156] (365s left) gem_exec_fence (syncobj-channel)
[660.707026] Starting subtest: syncobj-channel
[661.729228] Subtest syncobj-channel: SUCCESS (1.019s)
[662.488311] [131/156] (363s left) prime_vgem (fence-flip-hang)
[662.562092] Subtest fence-flip-hang: SKIP (0.000s)
[662.653193] [132/156] (363s left) i915_power (sanity)
[662.712770] Starting subtest: sanity
[666.766413] Subtest sanity: SUCCESS (4.048s)
[668.426372] [133/156] (357s left) perf_pmu (most-busy-check-all)
[668.469020] Starting subtest: most-busy-check-all
[668.471020] Starting dynamic subtest: rcs0
[670.390108] Dynamic subtest rcs0: SUCCESS (1.922s)
[670.402825] Starting dynamic subtest: bcs0
[672.436857] Dynamic subtest bcs0: SUCCESS (2.044s)
[672.447843] Starting dynamic subtest: vcs0
[674.420668] Dynamic subtest vcs0: SUCCESS (1.981s)
[674.433210] Starting dynamic subtest: vcs1
[676.404512] Dynamic subtest vcs1: SUCCESS (1.981s)
[676.416827] Starting dynamic subtest: vecs0
[678.453001] Dynamic subtest vecs0: SUCCESS (2.046s)
[678.466934] Starting dynamic subtest: ccs0
[680.438215] Dynamic subtest ccs0: SUCCESS (1.983s)
[680.441141] Subtest most-busy-check-all: SUCCESS (11.974s)
[680.532196] [134/156] (345s left) kms_flip (2x-flip-vs-fences)
[680.638595] Starting subtest: 2x-flip-vs-fences
[680.642997] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[680.747735] [135/156] (345s left) kms_pm_rpm (legacy-planes-dpms)
[682.569501] Starting subtest: legacy-planes-dpms
[682.572403] Starting dynamic subtest: plane-65
[690.932960] Dynamic subtest plane-65: SUCCESS (8.360s)
[690.945371] Starting dynamic subtest: plane-95
[699.278553] Dynamic subtest plane-95: SUCCESS (8.340s)
[699.298120] Starting dynamic subtest: plane-125
[707.621043] Dynamic subtest plane-125: SUCCESS (8.338s)
[707.633770] Starting dynamic subtest: plane-135
[715.921680] Dynamic subtest plane-135: SUCCESS (8.296s)
[715.924959] Subtest legacy-planes-dpms: SUCCESS (33.346s)
[716.327283] [136/156] (309s left) sysfs_heartbeat_interval (precise)
[716.386741] Starting subtest: precise
[716.389131] Starting dynamic subtest: vecs0
[724.395688] Dynamic subtest vecs0: SUCCESS (8.007s)
[724.410215] Starting dynamic subtest: ccs0
[725.474056] Dynamic subtest ccs0: SUCCESS (1.074s)
[725.484587] Starting dynamic subtest: vcs0
[733.427908] Dynamic subtest vcs0: SUCCESS (7.947s)
[733.439892] Starting dynamic subtest: bcs0
[734.522255] Dynamic subtest bcs0: SUCCESS (1.095s)
[734.535837] Starting dynamic subtest: rcs0
[735.626684] Dynamic subtest rcs0: SUCCESS (1.101s)
[735.639105] Starting dynamic subtest: vcs1
[743.414307] Dynamic subtest vcs1: SUCCESS (7.789s)
[743.417148] Subtest precise: SUCCESS (27.026s)
[743.496203] [137/156] (282s left) kms_prop_blob (invalid-get-prop)
[743.544219] Starting subtest: invalid-get-prop
[743.546575] Subtest invalid-get-prop: SUCCESS (0.000s)
[743.638029] [138/156] (282s left) syncobj_basic (bad-pad-fd-to-handle)
[743.687646] Starting subtest: bad-pad-fd-to-handle
[743.689561] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[743.784807] [139/156] (282s left) gem_vm_create (invalid-destroy)
[743.842946] Starting subtest: invalid-destroy
[743.845662] Subtest invalid-destroy: SUCCESS (0.002s)
[743.968469] [140/156] (282s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[744.079488] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[744.083317] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[744.149319] [141/156] (281s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[744.245922] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[744.249891] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[744.367691] [142/156] (281s left) kms_psr2_su (page_flip-xrgb8888)
[744.415764] Subtest page_flip-XRGB8888: SKIP (0.000s)
[744.487264] [143/156] (281s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[744.596125] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[744.599767] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[744.712653] [144/156] (281s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[744.803593] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[744.807167] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[744.909518] [145/156] (281s left) kms_hdr (static-toggle-suspend)
[745.008499] Starting subtest: static-toggle-suspend
[745.010388] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[745.013897] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[745.024033] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[745.027410] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[745.030803] Subtest static-toggle-suspend: SKIP (0.003s)
[745.081549] [146/156] (281s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[745.176550] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[745.180050] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[745.274477] [147/156] (281s left) gem_reg_read (bad-register)
[745.329257] Starting subtest: bad-register
[745.330830] Subtest bad-register: SUCCESS (0.000s)
[745.424379] [148/156] (280s left) gem_exec_store (pages)
[745.473996] Starting subtest: pages
[745.476053] Starting dynamic subtest: rcs0
[745.586144] Dynamic subtest rcs0: SUCCESS (0.112s)
[745.597836] Starting dynamic subtest: bcs0
[745.658635] Dynamic subtest bcs0: SUCCESS (0.071s)
[745.668257] Starting dynamic subtest: vcs0
[745.728341] Dynamic subtest vcs0: SUCCESS (0.069s)
[745.738083] Starting dynamic subtest: vcs1
[745.796052] Dynamic subtest vcs1: SUCCESS (0.066s)
[745.806230] Starting dynamic subtest: vecs0
[745.862644] Dynamic subtest vecs0: SUCCESS (0.066s)
[745.872654] Starting dynamic subtest: ccs0
[745.934746] Dynamic subtest ccs0: SUCCESS (0.070s)
[745.937169] Subtest pages: SUCCESS (0.461s)
[746.122668] [149/156] (280s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[746.217165] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[746.219604] Starting dynamic subtest: pipe-A-eDP-1
[746.240677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[746.252917] Starting dynamic subtest: pipe-B-eDP-1
[746.272877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[746.282973] Starting dynamic subtest: pipe-C-eDP-1
[746.302914] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[746.312984] Starting dynamic subtest: pipe-D-eDP-1
[746.333319] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[746.335484] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[748.464979] [150/156] (277s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[748.519670] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[748.625269] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[748.716655] [151/156] (277s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[748.821428] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[748.825557] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[748.919542] [152/156] (277s left) gem_tiled_swapping (non-threaded)
[748.972867] Subtest non-threaded: SKIP (0.000s)
[749.037868] [153/156] (277s left) syncobj_timeline (invalid-wait-illegal-handle)
[749.093801] Starting subtest: invalid-wait-illegal-handle
[749.095737] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[749.208741] [154/156] (277s left) kms_flip (2x-flip-vs-wf_vblank)
[749.295129] Starting subtest: 2x-flip-vs-wf_vblank
[749.307520] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[749.390834] [155/156] (277s left) kms_flip (basic-flip-vs-wf_vblank)
[749.483278] Starting subtest: basic-flip-vs-wf_vblank
[749.485771] Starting dynamic subtest: A-eDP1
[751.405958] Dynamic subtest A-eDP1: SUCCESS (1.924s)
[751.417134] Starting dynamic subtest: B-eDP1
[753.338854] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[753.352064] Starting dynamic subtest: C-eDP1
[755.260730] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[755.271265] Starting dynamic subtest: D-eDP1
[757.199416] Dynamic subtest D-eDP1: SUCCESS (1.936s)
[757.201813] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.722s)
[758.642474] [156/156] (268s left) i915_pm_rpm (gem-execbuf-stress)
[760.565088] Starting subtest: gem-execbuf-stress
[760.567740] Starting dynamic subtest: smem0
[773.469377] Dynamic subtest smem0: SUCCESS (12.903s)
[773.483262] Starting dynamic subtest: extra-wait-smem0
[835.250083] Dynamic subtest extra-wait-smem0: SUCCESS (61.780s)
[835.253048] Subtest gem-execbuf-stress: SUCCESS (74.689s)
[835.631899] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_dirtyfb
results: parsing output: 2/ for test: gem_userptr_blits
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: drm_read
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: core_setmaster
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gen7_exec_parse
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_pwrite_snooped
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_dsc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: prime_self_import
results: parsing output: 43/ for test: kms_busy
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: i915_hangman
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_content_protection
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_exec_create
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: i915_query
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: gem_ctx_shared
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: core_auth
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: api_intel_bb
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_atomic
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: gem_bad_reloc
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_rmfb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: i915_power
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: kms_pm_rpm
results: parsing output: 135/ for test: sysfs_heartbeat_interval
results: parsing output: 136/ for test: kms_prop_blob
results: parsing output: 137/ for test: syncobj_basic
results: parsing output: 138/ for test: gem_vm_create
results: parsing output: 139/ for test: kms_psr2_sf
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_psr2_su
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_hdr
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_reg_read
results: parsing output: 147/ for test: gem_exec_store
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: syncobj_timeline
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_tiled_swapping
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: kms_flip
results: parsing output: 155/ for test: i915_pm_rpm
Done.