[102.832309] Initializing watchdogs
[102.832356]   /dev/watchdog0
[102.846465] [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]
[102.850864] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.853149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.856623] [001/156] (960s left) i915_drm_fdinfo (most-busy-check-all)
[102.922418] Starting subtest: most-busy-check-all
[102.924760] Starting dynamic subtest: rcs0
[102.931737] Dynamic subtest rcs0: SKIP (0.006s)
[102.939316] Starting dynamic subtest: bcs0
[102.943338] Dynamic subtest bcs0: SKIP (0.000s)
[102.951078] Starting dynamic subtest: vcs0
[102.955342] Dynamic subtest vcs0: SKIP (0.000s)
[102.962127] Starting dynamic subtest: vcs1
[102.966191] Dynamic subtest vcs1: SKIP (0.000s)
[102.972467] Starting dynamic subtest: vecs0
[102.976471] Dynamic subtest vecs0: SKIP (0.000s)
[102.982816] Starting dynamic subtest: ccs0
[102.987053] Dynamic subtest ccs0: SKIP (0.000s)
[102.991133] Subtest most-busy-check-all: SKIP (0.008s)
[103.023070] [002/156] (960s left) kms_lease (implicit-plane-lease)
[103.151054] Starting subtest: implicit-plane-lease
[103.153461] Subtest implicit-plane-lease: SUCCESS (0.003s)
[103.245077] [003/156] (960s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[103.348316] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[103.352258] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[103.433074] [004/156] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[103.549187] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[104.565862] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.016s)
[105.410532] [005/156] (958s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[105.534880] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[105.690071] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.157s)
[105.805407] [006/156] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[105.907209] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[105.911166] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[106.010068] [007/156] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[106.115188] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[106.119272] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[106.204623] [008/156] (957s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[106.324098] Starting subtest: flip-vs-cursor-atomic-transitions
[114.227825] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.907s)
[115.037283] [009/156] (948s left) kms_rotation_crc (primary-rotation-270)
[115.132451] Starting subtest: primary-rotation-270
[115.136765] Subtest primary-rotation-270: SKIP (0.001s)
[115.212627] [010/156] (948s left) gem_exec_schedule (deep)
[115.399041] Starting subtest: deep
[115.401360] Starting dynamic subtest: rcs0
[120.321214] Dynamic subtest rcs0: SKIP (4.920s)
[120.331042] Starting dynamic subtest: vcs0
[130.411697] Dynamic subtest vcs0: SUCCESS (10.093s)
[130.420024] Starting dynamic subtest: vcs1
[142.511418] Dynamic subtest vcs1: SUCCESS (12.100s)
[142.521666] Starting dynamic subtest: vecs0
[154.450410] Dynamic subtest vecs0: SUCCESS (11.939s)
[154.459459] Starting dynamic subtest: ccs0
[166.383914] Dynamic subtest ccs0: SUCCESS (11.933s)
[166.388445] Subtest deep: SUCCESS (50.988s)
[167.246803] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[167.250039] [011/156] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[167.351700] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[167.356062] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[167.429312] [012/156] (896s left) api_intel_bb (reset-flags)
[167.483070] Starting subtest: reset-flags
[167.492198] Subtest reset-flags: SUCCESS (0.011s)
[167.610877] [013/156] (896s left) gem_spin_batch (resubmit-new-all)
[167.682479] Starting subtest: resubmit-new-all
[167.684874] Starting dynamic subtest: rcs0
[167.698247] Dynamic subtest rcs0: SUCCESS (0.016s)
[167.709353] Starting dynamic subtest: bcs0
[167.711542] Dynamic subtest bcs0: SUCCESS (0.010s)
[167.718889] Starting dynamic subtest: vcs0
[167.721207] Dynamic subtest vcs0: SUCCESS (0.010s)
[167.728951] Starting dynamic subtest: vcs1
[167.731299] Dynamic subtest vcs1: SUCCESS (0.008s)
[167.741638] Starting dynamic subtest: vecs0
[167.743625] Dynamic subtest vecs0: SUCCESS (0.011s)
[167.755634] Starting dynamic subtest: ccs0
[167.757781] Dynamic subtest ccs0: SUCCESS (0.011s)
[167.759882] Subtest resubmit-new-all: SUCCESS (0.069s)
[169.316104] [014/156] (894s left) kms_cursor_crc (cursor-random-128x128)
[169.516046] Starting subtest: cursor-random-128x128
[169.521364] Starting dynamic subtest: pipe-A-eDP-1
[172.907064] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.385s)
[172.937293] Starting dynamic subtest: pipe-D-eDP-1
[176.961855] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.029s)
[176.964385] Subtest cursor-random-128x128: SUCCESS (7.444s)
[177.801872] [015/156] (886s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[177.905177] Starting subtest: yf-tiled-32bpp-rotate-180
[177.909456] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[178.005282] [016/156] (885s left) perf (gen12-group-concurrent-oa-buffer-read)
[178.118887] Starting subtest: gen12-group-concurrent-oa-buffer-read
[188.147064] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.024s)
[188.192177] [017/156] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[188.296889] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[188.301444] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[188.415304] [018/156] (875s left) gem_mmap_gtt (cpuset-big-copy-odd)
[188.477289] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[188.542044] [019/156] (875s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[188.642030] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[188.646115] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.735875] [020/156] (875s left) kms_dsc (dsc-fractional-bpp)
[188.824937] Starting subtest: dsc-fractional-bpp
[188.837827] Subtest dsc-fractional-bpp: SKIP (0.000s)
[188.906722] [021/156] (875s left) gem_partial_pwrite_pread (reads-display)
[188.973873] Subtest reads-display: SKIP (0.000s)
[189.052049] [022/156] (875s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[189.153147] Starting subtest: 4-tiled-32bpp-rotate-90
[189.171575] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[189.272214] [023/156] (874s left) gem_eio (reset-stress)
[189.506137] Starting subtest: reset-stress
[189.508182] Starting dynamic subtest: render
[194.390997] Dynamic subtest render: SUCCESS (4.880s)
[194.406242] Starting dynamic subtest: bsd1
[212.802809] Dynamic subtest bsd1: SUCCESS (18.411s)
[212.819812] Starting dynamic subtest: bsd2
[230.754173] Dynamic subtest bsd2: SUCCESS (17.949s)
[230.767726] Starting dynamic subtest: blt
[230.772025] Dynamic subtest blt: SKIP (0.000s)
[230.780250] Starting dynamic subtest: vebox
[248.849704] Dynamic subtest vebox: SUCCESS (18.093s)
[248.852116] Subtest reset-stress: SUCCESS (59.335s)
[250.366439] [024/156] (813s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[250.742737] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[251.608238] [025/156] (812s left) gem_exercise_blt (fast-copy-emit)
[251.676771] Starting subtest: fast-copy-emit
[251.678763] Starting dynamic subtest: linear-smem-smem-emit
[251.699132] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[251.708102] Starting dynamic subtest: xmajor-smem-smem-emit
[251.717056] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[251.724954] Starting dynamic subtest: tile4-smem-smem-emit
[251.734866] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[251.742735] Starting dynamic subtest: tile64-smem-smem-emit
[251.751064] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[251.753513] Subtest fast-copy-emit: SUCCESS (0.077s)
[251.883139] [026/156] (812s left) kms_psr (psr2-primary-render)
[251.969089] Starting subtest: psr2-primary-render
[251.971400] Starting dynamic subtest: eDP-1
[253.728270] Dynamic subtest eDP-1: SUCCESS (1.759s)
[253.730736] Subtest psr2-primary-render: SUCCESS (1.760s)
[254.598267] [027/156] (809s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[254.705276] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[254.709749] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[254.795021] [028/156] (809s left) prime_vgem (fence-wait)
[254.885698] Starting subtest: fence-wait
[254.887691] Starting dynamic subtest: rcs0
[255.930557] Dynamic subtest rcs0: SUCCESS (1.044s)
[255.941582] Starting dynamic subtest: bcs0
[256.998878] Dynamic subtest bcs0: SUCCESS (1.067s)
[257.010823] Starting dynamic subtest: vcs0
[258.042923] Dynamic subtest vcs0: SUCCESS (1.043s)
[258.054064] Starting dynamic subtest: vcs1
[259.088539] Dynamic subtest vcs1: SUCCESS (1.044s)
[259.099259] Starting dynamic subtest: vecs0
[260.130577] Dynamic subtest vecs0: SUCCESS (1.041s)
[260.142038] Starting dynamic subtest: ccs0
[261.177325] Dynamic subtest ccs0: SUCCESS (1.046s)
[261.179993] Subtest fence-wait: SUCCESS (6.291s)
[261.307947] [029/156] (803s left) syncobj_wait (wait-any-complex)
[261.353898] Starting subtest: wait-any-complex
[261.414897] Subtest wait-any-complex: SUCCESS (0.062s)
[261.492380] [030/156] (802s left) gem_exec_suspend (basic-s0)
[261.561996] Starting subtest: basic-S0
[261.564414] Starting dynamic subtest: smem
[281.891473] Dynamic subtest smem: SUCCESS (6.737s)
[281.894400] Subtest basic-S0: SUCCESS (6.738s)
[282.067987] [031/156] (782s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[282.155716] Starting subtest: map-fixed-invalidate-overlap-busy
[282.159766] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[282.288275] [032/156] (782s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[282.393833] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[282.397933] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[282.488252] [033/156] (782s left) gem_ctx_persistence (heartbeat-hang)
[282.545475] Starting subtest: heartbeat-hang
[282.550106] Subtest heartbeat-hang: SKIP (0.000s)
[282.638569] [034/156] (781s left) kms_flip (flip-vs-panning)
[282.730464] Starting subtest: flip-vs-panning
[282.732848] Starting dynamic subtest: A-eDP1
[291.481499] Dynamic subtest A-eDP1: SUCCESS (8.858s)
[291.490813] Starting dynamic subtest: B-eDP1
[300.199322] Dynamic subtest B-eDP1: SUCCESS (8.754s)
[300.210628] Starting dynamic subtest: C-eDP1
[308.907743] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[308.917726] Starting dynamic subtest: D-eDP1
[317.616429] Dynamic subtest D-eDP1: SUCCESS (8.708s)
[317.618463] Subtest flip-vs-panning: SUCCESS (35.049s)
[318.786509] [035/156] (745s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[318.893516] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc
[318.898245] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[319.005704] [036/156] (745s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[319.099600] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[319.104014] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[319.195288] [037/156] (745s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[319.293648] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[319.297697] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[319.400112] [038/156] (745s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[319.493272] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[319.497886] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[320.616489] [039/156] (744s left) kms_cursor_crc (cursor-random-256x85)
[320.864529] Starting subtest: cursor-random-256x85
[320.908945] Subtest cursor-random-256x85: SKIP (0.040s)
[321.086697] [040/156] (743s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[321.180219] Starting subtest: hdr-farfromfence-mmap-gtt
[321.184508] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[321.290288] [041/156] (743s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[321.393802] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[321.397887] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[321.484492] [042/156] (743s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[321.586179] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[321.589677] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[321.693291] [043/156] (743s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[321.791584] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[321.795109] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[321.884493] [044/156] (743s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[322.013074] Starting subtest: 2x-flip-vs-cursor-legacy
[322.017078] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[322.156516] [045/156] (742s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[322.551397] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[323.339832] [046/156] (741s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[323.441575] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[323.443898] Starting dynamic subtest: pipe-A-eDP-1
[323.535885] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[323.545448] Starting dynamic subtest: pipe-B-eDP-1
[324.743634] Dynamic subtest pipe-B-eDP-1: SKIP (1.204s)
[324.748138] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.306s)
[325.927923] [047/156] (739s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[326.025091] Starting subtest: x-tiled-addfb-size-offset-overflow
[326.027579] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[326.143726] [048/156] (739s left) gem_create (create-ext-set-pat)
[326.306907] Starting subtest: create-ext-set-pat
[326.309108] Subtest create-ext-set-pat: SUCCESS (0.001s)
[326.418191] [049/156] (738s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[326.468808] Starting subtest: etime-single-wait-all-available-unsubmitted
[326.575112] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s)
[326.660517] [050/156] (738s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[326.747528] Starting subtest: psr2-overlay-plane-move-continuous-sf
[326.750029] Starting dynamic subtest: pipe-A-eDP-1
[332.714321] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.973s)
[332.725088] Starting dynamic subtest: pipe-B-eDP-1
[339.412362] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.696s)
[339.414794] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.671s)
[340.287333] [051/156] (725s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[340.383727] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[340.387848] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[340.484473] [052/156] (724s left) gem_madvise (dontneed-before-mmap)
[340.518720] Starting subtest: dontneed-before-mmap
[340.545170] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[340.641038] [053/156] (724s left) kms_busy (extended-modeset-hang-oldfb)
[340.748075] Starting subtest: extended-modeset-hang-oldfb
[340.750330] Starting dynamic subtest: pipe-A
[352.366762] Dynamic subtest pipe-A: SUCCESS (11.621s)
[352.377698] Starting dynamic subtest: pipe-D
[364.620917] Dynamic subtest pipe-D: SUCCESS (12.255s)
[364.623418] Subtest extended-modeset-hang-oldfb: SUCCESS (23.879s)
[365.505805] [054/156] (699s left) kms_content_protection (atomic-dpms-hdcp14)
[365.641776] Starting subtest: atomic-dpms-hdcp14
[365.646432] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[365.772020] [055/156] (699s left) kms_psr (psr2-cursor-mmap-cpu)
[365.865188] Starting subtest: psr2-cursor-mmap-cpu
[365.867504] Starting dynamic subtest: eDP-1
[367.579753] Dynamic subtest eDP-1: SUCCESS (1.715s)
[367.581693] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.715s)
[368.459467] [056/156] (697s left) kms_atomic_interruptible (legacy-cursor)
[368.544058] Starting subtest: legacy-cursor
[368.546429] Starting dynamic subtest: pipe-A-eDP-1
[375.985819] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[375.988213] Subtest legacy-cursor: SUCCESS (7.445s)
[376.829963] [057/156] (688s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[376.943104] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[376.947259] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[377.030701] [058/156] (688s left) i915_query (query-regions-garbage-items)
[377.084607] Starting subtest: query-regions-garbage-items
[377.086908] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[377.181312] [059/156] (688s left) gem_mmap_offset (partial-mmap)
[377.228422] Starting subtest: partial-mmap
[377.230669] Starting dynamic subtest: smem0
[377.232945] Dynamic subtest smem0: SUCCESS (0.004s)
[377.235126] Subtest partial-mmap: SUCCESS (0.004s)
[377.351362] [060/156] (688s left) kms_addfb_basic (bad-pitch-1024)
[377.401631] Starting subtest: bad-pitch-1024
[377.404021] Subtest bad-pitch-1024: SUCCESS (0.000s)
[377.541601] [061/156] (688s left) kms_atomic (plane-immutable-zpos)
[377.629581] Starting subtest: plane-immutable-zpos
[377.631787] Starting dynamic subtest: pipe-A-eDP-1
[378.254511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[378.256718] Subtest plane-immutable-zpos: SUCCESS (0.624s)
[379.066820] [062/156] (686s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[379.161511] Starting subtest: fbc-psr2-primary-mmap-gtt
[379.163765] Starting dynamic subtest: eDP-1
[379.168334] Dynamic subtest eDP-1: SKIP (0.000s)
[379.172854] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[379.231909] [063/156] (686s left) kms_cursor_legacy (single-bo)
[379.355445] Starting subtest: single-bo
[379.357762] Starting dynamic subtest: pipe-A
[384.741223] Dynamic subtest pipe-A: SUCCESS (5.379s)
[384.752222] Starting dynamic subtest: pipe-B
[390.125235] Dynamic subtest pipe-B: SUCCESS (5.379s)
[390.138747] Starting dynamic subtest: pipe-C
[395.509707] Dynamic subtest pipe-C: SUCCESS (5.380s)
[395.525461] Starting dynamic subtest: pipe-D
[400.892942] Dynamic subtest pipe-D: SUCCESS (5.381s)
[400.903640] Starting dynamic subtest: all-pipes
[406.281626] Dynamic subtest all-pipes: SUCCESS (5.385s)
[406.284292] Subtest single-bo: SUCCESS (26.915s)
[406.427393] [064/156] (659s left) kms_plane_multiple (tiling-none)
[406.527989] Starting subtest: tiling-none
[406.529849] Starting dynamic subtest: pipe-A-eDP-1
[410.315718] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.788s)
[410.325545] Starting dynamic subtest: pipe-B-eDP-1
[414.869471] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.552s)
[414.880507] Starting dynamic subtest: pipe-C-eDP-1
[419.334134] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.462s)
[419.344784] Starting dynamic subtest: pipe-D-eDP-1
[423.890753] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.554s)
[423.893083] Subtest tiling-none: SUCCESS (17.362s)
[424.701095] [065/156] (641s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[424.805615] Starting subtest: y-tiled-32bpp-rotate-270
[424.810073] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[424.903916] [066/156] (641s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[424.998332] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[425.002330] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[425.102316] [067/156] (640s left) drm_read (fault-buffer)
[425.258939] Starting subtest: fault-buffer
[425.260953] Subtest fault-buffer: SUCCESS (0.000s)
[425.391972] [068/156] (640s left) gem_mmap_gtt (big-bo)
[425.453074] Subtest big-bo: SKIP (0.000s)
[425.522082] [069/156] (640s left) fbdev (unaligned-write)
[425.565307] Starting subtest: unaligned-write
[425.662886] Subtest unaligned-write: SUCCESS (0.099s)
[425.726180] [070/156] (640s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[425.779728] Starting subtest: y-tiled-to-vebox-yf-tiled
[425.783322] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[425.961788] [071/156] (640s left) gem_ctx_shared (q-independent)
[426.028186] Starting subtest: Q-independent
[426.030593] Starting dynamic subtest: rcs0
[426.095012] Dynamic subtest rcs0: SUCCESS (0.066s)
[426.107829] Starting dynamic subtest: vcs0
[426.136427] Dynamic subtest vcs0: SUCCESS (0.041s)
[426.145694] Starting dynamic subtest: vcs1
[426.179382] Dynamic subtest vcs1: SUCCESS (0.042s)
[426.190417] Starting dynamic subtest: vecs0
[426.221586] Dynamic subtest vecs0: SUCCESS (0.042s)
[426.231831] Starting dynamic subtest: ccs0
[426.267480] Dynamic subtest ccs0: SUCCESS (0.045s)
[426.269832] Subtest Q-independent: SUCCESS (0.240s)
[427.963494] [072/156] (638s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[428.054964] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[428.059004] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[428.127160] [073/156] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[428.233336] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[431.761895] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.532s)
[432.915620] [074/156] (633s left) kms_cursor_crc (cursor-sliding-512x170)
[433.209922] Starting subtest: cursor-sliding-512x170
[433.214495] Subtest cursor-sliding-512x170: SKIP (0.001s)
[433.369547] [075/156] (632s left) kms_pm_rpm (pm-caching)
[435.102250] Starting subtest: pm-caching
[435.107073] Subtest pm-caching: SKIP (0.000s)
[435.642265] [076/156] (630s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[435.740034] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[435.744344] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[435.850539] [077/156] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[435.948918] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[435.953086] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[436.049437] [078/156] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[436.159061] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[440.197021] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.044s)
[441.367236] [079/156] (625s left) kms_plane (plane-panning-bottom-right-suspend)
[441.477595] Starting subtest: plane-panning-bottom-right-suspend
[441.480009] Starting dynamic subtest: pipe-A
[459.149841] Dynamic subtest pipe-A: SUCCESS (2.893s)
[459.160428] Starting dynamic subtest: pipe-B
[478.167748] Dynamic subtest pipe-B: SUCCESS (3.523s)
[478.169993] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.420s)
[478.967063] [080/156] (587s left) perf_pmu (invalid-open)
[479.011570] Starting subtest: invalid-open
[479.013880] Subtest invalid-open: SUCCESS (0.000s)
[479.125199] [081/156] (587s left) syncobj_timeline (multi-wait-signaled)
[479.177382] Starting subtest: multi-wait-signaled
[479.179575] Subtest multi-wait-signaled: SUCCESS (0.001s)
[479.295941] [082/156] (587s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[479.389442] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[479.393826] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[479.496666] [083/156] (587s left) kms_psr (fbc-psr-sprite-render)
[479.582889] Starting subtest: fbc-psr-sprite-render
[479.584996] Starting dynamic subtest: eDP-1
[479.588856] Dynamic subtest eDP-1: SKIP (0.000s)
[479.592616] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[479.670040] [084/156] (586s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[479.771338] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[479.775762] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.879378] [085/156] (586s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[479.985266] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[479.988751] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[480.094251] [086/156] (586s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[480.184549] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[480.187889] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[480.286876] [087/156] (586s left) i915_hangman (gt-engine-hang)
[480.344457] Starting subtest: gt-engine-hang
[480.346191] Starting dynamic subtest: rcs0
[482.116115] Dynamic subtest rcs0: SUCCESS (1.799s)
[482.127394] Starting dynamic subtest: bcs0
[484.162630] Dynamic subtest bcs0: SUCCESS (2.069s)
[484.173989] Starting dynamic subtest: vcs0
[486.145409] Dynamic subtest vcs0: SUCCESS (1.999s)
[486.158482] Starting dynamic subtest: vcs1
[488.129950] Dynamic subtest vcs1: SUCCESS (1.997s)
[488.144484] Starting dynamic subtest: vecs0
[490.115602] Dynamic subtest vecs0: SUCCESS (1.995s)
[490.126517] Starting dynamic subtest: ccs0
[492.162391] Dynamic subtest ccs0: SUCCESS (2.053s)
[492.165187] Subtest gt-engine-hang: SUCCESS (11.928s)
[492.245480] [088/156] (574s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[492.338052] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[492.342733] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[492.414239] [089/156] (574s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[492.543669] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[493.531629] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.991s)
[494.351407] [090/156] (572s left) gem_basic (create-fd-close)
[494.402132] Starting subtest: create-fd-close
[494.406228] Subtest create-fd-close: SUCCESS (0.000s)
[494.497716] [091/156] (572s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[494.549193] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[494.655498] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[494.737290] [092/156] (572s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[494.872762] Starting subtest: 2x-cursor-vs-flip-legacy
[494.877490] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[495.025961] [093/156] (571s left) gem_mmap_wc (write-gtt-read-wc)
[495.084785] Subtest write-gtt-read-wc: SKIP (0.000s)
[495.143245] [094/156] (571s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[495.242858] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[495.247407] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[495.368998] [095/156] (571s left) gem_exec_params (secure-non-master)
[495.422384] Starting subtest: secure-non-master
[495.426828] Subtest secure-non-master: SKIP (0.000s)
[495.519931] [096/156] (571s left) gem_exec_fence (syncobj-timeline-export)
[496.072296] Starting subtest: syncobj-timeline-export
[496.078678] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[497.272956] [097/156] (569s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[497.326669] Starting subtest: x-tiled-to-vebox-y-tiled
[497.331133] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[497.506156] [098/156] (569s left) device_reset (unbind-cold-reset-rebind)
[497.548182] Starting subtest: unbind-cold-reset-rebind
[497.552779] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[497.627733] [099/156] (569s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[497.727568] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[497.731579] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[497.836581] [100/156] (569s left) syncobj_timeline (single-wait-available-signaled)
[497.886015] Starting subtest: single-wait-available-signaled
[497.888178] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[497.976639] [101/156] (569s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[498.075327] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[502.748978] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.684s)
[502.847735] [102/156] (564s left) gem_ctx_param (invalid-set-no-zeromap)
[502.907013] Starting subtest: invalid-set-no-zeromap
[502.909409] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[502.980072] [103/156] (564s left) gem_exec_flush (basic-wb-rw-default)
[503.035641] Starting subtest: basic-wb-rw-default
[508.481341] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[508.680835] [104/156] (558s left) gem_exec_reloc (basic-wc-active)
[508.736658] Subtest basic-wc-active: SKIP (0.000s)
[508.795815] [105/156] (558s left) kms_async_flips (crc-atomic)
[508.885090] Starting subtest: crc-atomic
[509.271987] Starting dynamic subtest: pipe-A-eDP-1
[512.167824] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.896s)
[512.554993] Starting dynamic subtest: pipe-B-eDP-1
[515.532611] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.983s)
[515.906292] Starting dynamic subtest: pipe-C-eDP-1
[518.825087] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.925s)
[519.195549] Starting dynamic subtest: pipe-D-eDP-1
[522.051027] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s)
[522.053329] Subtest crc-atomic: SUCCESS (13.166s)
[523.231516] [106/156] (544s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[523.328189] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[523.332199] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[523.431219] [107/156] (544s left) kms_pm_rpm (fences-dpms)
[525.273660] Starting subtest: fences-dpms
[525.278632] Subtest fences-dpms: SKIP (0.000s)
[525.686283] [108/156] (541s left) i915_query (query-topology-unsupported)
[525.743600] Starting subtest: query-topology-unsupported
[525.747977] Subtest query-topology-unsupported: SKIP (0.000s)
[525.861451] [109/156] (541s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[525.960862] Starting subtest: plane-lut1d-ctm3x4
[526.128619] Starting dynamic subtest: pipe-A-plane-0
[526.295484] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[526.307430] Starting dynamic subtest: pipe-A-plane-1
[526.428900] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[526.439114] Starting dynamic subtest: pipe-A-plane-2
[526.561762] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[527.794078] Starting dynamic subtest: pipe-B-plane-0
[527.986071] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[527.999458] Starting dynamic subtest: pipe-B-plane-1
[528.152816] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[528.163191] Starting dynamic subtest: pipe-B-plane-2
[528.330617] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[529.493340] Starting dynamic subtest: pipe-C-plane-0
[529.627961] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[529.637362] Starting dynamic subtest: pipe-C-plane-1
[529.771947] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[529.782150] Starting dynamic subtest: pipe-C-plane-2
[529.916396] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[531.130322] Starting dynamic subtest: pipe-D-plane-0
[531.277505] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[531.287830] Starting dynamic subtest: pipe-D-plane-1
[531.411224] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[531.424067] Starting dynamic subtest: pipe-D-plane-2
[531.544362] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[531.834264] Subtest plane-lut1d-ctm3x4: SUCCESS (5.873s)
[532.704049] [110/156] (535s left) kms_chamelium_color (ctm-0-75)
[532.807676] Subtest ctm-0-75: SKIP (0.000s)
[532.855223] [111/156] (534s left) kms_psr2_su (page_flip-nv12)
[532.908499] Subtest page_flip-NV12: SKIP (0.000s)
[532.977609] [112/156] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[533.082511] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[540.432986] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.357s)
[540.565844] [113/156] (527s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[540.662222] Starting subtest: primary-y-tiled-reflect-x-270
[540.666665] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[540.736699] [114/156] (527s left) api_intel_bb (add-remove-objects)
[540.788948] Starting subtest: add-remove-objects
[540.800024] Subtest add-remove-objects: SUCCESS (0.012s)
[540.931095] [115/156] (526s left) gem_partial_pwrite_pread (write-snoop)
[540.983173] Subtest write-snoop: SKIP (0.000s)
[541.047916] [116/156] (526s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[541.158538] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[541.162541] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[541.258154] [117/156] (526s left) kms_flip (dpms-off-confusion-interruptible)
[541.355606] Starting subtest: dpms-off-confusion-interruptible
[541.357984] Starting dynamic subtest: A-eDP1
[550.039423] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[550.050495] Starting dynamic subtest: B-eDP1
[558.680547] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[558.690499] Starting dynamic subtest: C-eDP1
[567.302045] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[567.313406] Starting dynamic subtest: D-eDP1
[575.943010] Dynamic subtest D-eDP1: SUCCESS (8.642s)
[575.948662] Subtest dpms-off-confusion-interruptible: SUCCESS (34.602s)
[577.193587] [118/156] (490s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[577.292283] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[577.294626] Starting dynamic subtest: pipe-A
[577.312728] Dynamic subtest pipe-A: SKIP (0.017s)
[577.323841] Starting dynamic subtest: pipe-B
[577.345233] Dynamic subtest pipe-B: SKIP (0.031s)
[577.355054] Starting dynamic subtest: pipe-C
[577.375453] Dynamic subtest pipe-C: SKIP (0.030s)
[577.384996] Starting dynamic subtest: pipe-D
[577.406244] Dynamic subtest pipe-D: SKIP (0.029s)
[577.410693] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[577.491546] [119/156] (490s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[577.579253] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[577.581597] Starting dynamic subtest: pipe-A-eDP-1
[577.602665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[577.614133] Starting dynamic subtest: pipe-B-eDP-1
[577.634726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[577.644678] Starting dynamic subtest: pipe-C-eDP-1
[577.664966] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[577.674828] Starting dynamic subtest: pipe-D-eDP-1
[577.695515] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[577.697735] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[579.949303] [120/156] (488s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[580.044717] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[580.049102] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[580.145452] [121/156] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[580.236054] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[580.240042] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[580.364451] [122/156] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[580.464487] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[587.222830] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.763s)
[587.358538] [123/156] (480s left) kms_pipe_crc_basic (suspend-read-crc)
[587.444013] Starting subtest: suspend-read-crc
[587.446311] Starting dynamic subtest: pipe-A-eDP-1
[605.650897] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.520s)
[605.662132] Starting dynamic subtest: pipe-B-eDP-1
[623.671574] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.249s)
[623.682285] Starting dynamic subtest: pipe-C-eDP-1
[641.600774] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.148s)
[641.610420] Starting dynamic subtest: pipe-D-eDP-1
[659.605316] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.082s)
[659.607672] Subtest suspend-read-crc: SUCCESS (12.004s)
[660.418332] [124/156] (407s left) kms_flip (basic-flip-vs-dpms)
[660.514198] Starting subtest: basic-flip-vs-dpms
[660.516386] Starting dynamic subtest: A-eDP1
[663.092358] Dynamic subtest A-eDP1: SUCCESS (2.617s)
[663.103569] Starting dynamic subtest: B-eDP1
[665.337769] Dynamic subtest B-eDP1: SUCCESS (2.269s)
[665.347830] Starting dynamic subtest: C-eDP1
[667.557614] Dynamic subtest C-eDP1: SUCCESS (2.241s)
[667.570046] Starting dynamic subtest: D-eDP1
[669.740829] Dynamic subtest D-eDP1: SUCCESS (2.194s)
[669.743050] Subtest basic-flip-vs-dpms: SUCCESS (9.330s)
[670.553634] [125/156] (397s left) gem_exec_schedule (preempt-other)
[670.625947] Starting subtest: preempt-other
[670.628317] Starting dynamic subtest: rcs0
[670.685023] Dynamic subtest rcs0: SUCCESS (0.069s)
[670.696688] Starting dynamic subtest: bcs0
[670.751147] Dynamic subtest bcs0: SUCCESS (0.066s)
[670.764658] Starting dynamic subtest: vcs0
[670.813092] Dynamic subtest vcs0: SUCCESS (0.062s)
[670.828982] Starting dynamic subtest: vcs1
[670.880442] Dynamic subtest vcs1: SUCCESS (0.067s)
[670.891352] Starting dynamic subtest: vecs0
[670.948746] Dynamic subtest vecs0: SUCCESS (0.068s)
[670.965485] Starting dynamic subtest: ccs0
[671.011731] Dynamic subtest ccs0: SUCCESS (0.062s)
[671.014339] Subtest preempt-other: SUCCESS (0.398s)
[672.651229] [126/156] (395s left) gem_mmap_gtt (basic-read-write)
[672.716198] Subtest basic-read-write: SKIP (0.000s)
[672.779363] [127/156] (395s left) i915_pm_rc6_residency (rc6-idle)
[672.829152] Starting subtest: rc6-idle
[672.856473] Starting dynamic subtest: gt0-rcs0
[697.154975] Dynamic subtest gt0-rcs0: SUCCESS (24.326s)
[697.165555] Starting dynamic subtest: gt0-bcs0
[721.456543] Dynamic subtest gt0-bcs0: SUCCESS (24.299s)
[721.468723] Starting dynamic subtest: gt0-ccs0
[745.829671] Dynamic subtest gt0-ccs0: SUCCESS (24.378s)
[745.840555] Starting dynamic subtest: gt1-vcs0
[752.004974] Dynamic subtest gt1-vcs0: SUCCESS (6.173s)
[752.018209] Starting dynamic subtest: gt1-vecs0
[758.181016] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[758.183536] Subtest rc6-idle: SUCCESS (85.390s)
[758.263875] [128/156] (310s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[758.357070] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[758.359270] Starting dynamic subtest: pipe-A-eDP-1
[758.417038] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[758.426830] Starting dynamic subtest: pipe-B-eDP-1
[758.483198] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[758.493206] Starting dynamic subtest: pipe-C-eDP-1
[758.548127] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[758.557586] Starting dynamic subtest: pipe-D-eDP-1
[758.611967] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[758.616043] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[760.646903] [129/156] (307s left) kms_hdr (invalid-metadata-sizes)
[760.738489] Starting subtest: invalid-metadata-sizes
[760.740868] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[760.745274] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[760.754917] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[760.759522] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[760.764214] Subtest invalid-metadata-sizes: SKIP (0.003s)
[760.811514] [130/156] (307s left) sysfs_heartbeat_interval (invalid)
[760.870524] Starting subtest: invalid
[760.872974] Starting dynamic subtest: vecs0
[760.875376] Dynamic subtest vecs0: SUCCESS (0.000s)
[760.886601] Starting dynamic subtest: ccs0
[760.888951] Dynamic subtest ccs0: SUCCESS (0.000s)
[760.898095] Starting dynamic subtest: vcs0
[760.900174] Dynamic subtest vcs0: SUCCESS (0.000s)
[760.909180] Starting dynamic subtest: bcs0
[760.911315] Dynamic subtest bcs0: SUCCESS (0.000s)
[760.920539] Starting dynamic subtest: rcs0
[760.922665] Dynamic subtest rcs0: SUCCESS (0.000s)
[760.932230] Starting dynamic subtest: vcs1
[760.934064] Dynamic subtest vcs1: SUCCESS (0.000s)
[760.935855] Subtest invalid: SUCCESS (0.005s)
[760.988305] [131/156] (307s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[761.089453] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[761.093507] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[761.198868] [132/156] (307s left) gen7_exec_parse (basic-offset)
[761.257226] Subtest basic-offset: SKIP (0.000s)
[761.315072] [133/156] (307s left) gem_exec_fence (basic-wait-all)
[761.382494] Starting subtest: basic-wait-all
[761.474331] Subtest basic-wait-all: SUCCESS (0.092s)
[763.562448] [134/156] (305s left) kms_universal_plane (disable-primary-vs-flip)
[763.656180] Starting subtest: disable-primary-vs-flip
[763.658600] Starting dynamic subtest: pipe-A-eDP-1
[765.239141] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.582s)
[765.249257] Starting dynamic subtest: pipe-B-eDP-1
[767.509513] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.267s)
[767.520512] Starting dynamic subtest: pipe-C-eDP-1
[769.761768] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.251s)
[769.772331] Starting dynamic subtest: pipe-D-eDP-1
[772.018532] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.254s)
[772.020482] Subtest disable-primary-vs-flip: SUCCESS (8.359s)
[772.912595] [135/156] (295s left) gen9_exec_parse (bb-large)
[772.978208] Subtest bb-large: SKIP (0.000s)
[773.051511] [136/156] (295s left) gem_userptr_blits (readonly-pwrite-unsync)
[773.108490] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[773.232420] [137/156] (295s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[773.321865] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[773.326273] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[773.432947] [138/156] (295s left) gem_exec_balancer (parallel-out-fence)
[773.687954] Starting subtest: parallel-out-fence
[774.820954] Subtest parallel-out-fence: SUCCESS (1.133s)
[774.944871] [139/156] (293s left) gem_gtt_cpu_tlb
[775.064632] [140/156] (293s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[775.159098] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[775.161385] Starting dynamic subtest: pipe-A-eDP-1
[775.303654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[775.316320] Starting dynamic subtest: pipe-B-eDP-1
[775.336334] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[775.346389] Starting dynamic subtest: pipe-C-eDP-1
[775.365069] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[775.375913] Starting dynamic subtest: pipe-D-eDP-1
[775.395593] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[775.397518] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[777.560784] [141/156] (291s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[777.655082] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[785.019408] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.368s)
[785.155743] [142/156] (283s left) syncobj_basic (bad-destroy)
[785.220239] Starting subtest: bad-destroy
[785.222557] Subtest bad-destroy: SUCCESS (0.000s)
[785.308939] [143/156] (283s left) kms_atomic_transition (plane-all-transition-fencing)
[785.403368] Starting subtest: plane-all-transition-fencing
[785.405742] Starting dynamic subtest: pipe-A-eDP-1
[787.898045] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[788.212432] Starting dynamic subtest: pipe-B-eDP-1
[791.421024] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.218s)
[791.732822] Subtest plane-all-transition-fencing: SUCCESS (6.330s)
[792.559482] [144/156] (276s left) syncobj_timeline (invalid-query-illegal-handle)
[792.613422] Starting subtest: invalid-query-illegal-handle
[792.615869] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[792.728523] [145/156] (276s left) kms_vblank (wait-busy-hang)
[792.823035] Starting subtest: wait-busy-hang
[792.825170] Starting dynamic subtest: pipe-A-eDP-1
[819.294410] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.474s)
[819.309259] Starting dynamic subtest: pipe-D-eDP-1
[834.270519] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[834.272873] Subtest wait-busy-hang: SUCCESS (41.455s)
[835.145809] [146/156] (234s left) gem_exec_balancer (nop)
[835.203568] Starting subtest: nop
[881.785990] Subtest nop: SUCCESS (46.592s)
[882.105410] [147/156] (187s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[882.200814] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[882.205151] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[882.288706] [148/156] (187s left) kms_big_fb (linear-64bpp-rotate-270)
[882.390388] Starting subtest: linear-64bpp-rotate-270
[882.411529] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[882.538209] [149/156] (186s left) gem_userptr_blits (map-fixed-invalidate-busy)
[882.591052] Starting subtest: map-fixed-invalidate-busy
[882.595173] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[882.719938] [150/156] (186s left) gem_exec_reloc (basic-wc-read)
[882.775504] Subtest basic-wc-read: SKIP (0.000s)
[882.853858] [151/156] (186s left) kms_lease (lessee-list)
[882.937793] Starting subtest: lessee-list
[882.939988] Starting dynamic subtest: pipe-A-eDP-1
[882.942259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[882.956818] Starting dynamic subtest: pipe-B-eDP-1
[882.958965] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[882.968700] Starting dynamic subtest: pipe-C-eDP-1
[882.970867] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[882.980653] Starting dynamic subtest: pipe-D-eDP-1
[882.982890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[882.985095] Subtest lessee-list: SUCCESS (0.008s)
[883.068105] [152/156] (186s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[883.150384] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[883.176590] Starting dynamic subtest: pipe-A-plane-0
[883.465233] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[883.475315] Starting dynamic subtest: pipe-A-plane-3
[883.721168] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[883.730760] Starting dynamic subtest: pipe-A-plane-5
[883.734231] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[884.813629] Starting dynamic subtest: pipe-B-plane-0
[885.105537] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[885.116484] Starting dynamic subtest: pipe-B-plane-3
[885.338664] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[885.352346] Starting dynamic subtest: pipe-B-plane-5
[885.356728] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[885.650486] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.499s)
[886.489190] [153/156] (183s left) kms_psr (psr-sprite-blt)
[886.589295] Starting subtest: psr-sprite-blt
[886.591642] Starting dynamic subtest: eDP-1
[888.287271] Dynamic subtest eDP-1: SUCCESS (1.696s)
[888.289596] Subtest psr-sprite-blt: SUCCESS (1.697s)
[889.144405] [154/156] (180s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[889.196534] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[889.273711] [155/156] (180s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[889.328876] Subtest tiled-to-tiled: SKIP (0.000s)
[889.409271] [156/156] (180s left) gem_exec_schedule (semaphore-codependency)
[889.472319] Starting subtest: semaphore-codependency
[889.478637] Subtest semaphore-codependency: SUCCESS (0.015s)
[889.830865] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_pxp
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_dsc
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: gem_exercise_blt
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_exec_suspend
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_chamelium_frames
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_create
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_madvise
results: parsing output: 52/ for test: kms_busy
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_atomic_interruptible
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_atomic
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_plane_multiple
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: drm_read
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: fbdev
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_basic
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: device_reset
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: kms_color_pipeline
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_psr2_su
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: gem_partial_pwrite_pread
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pipe_crc_basic
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: i915_pm_rc6_residency
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_hdr
results: parsing output: 129/ for test: sysfs_heartbeat_interval
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gen7_exec_parse
results: parsing output: 132/ for test: gem_exec_fence
results: parsing output: 133/ for test: kms_universal_plane
results: parsing output: 134/ for test: gen9_exec_parse
results: parsing output: 135/ for test: gem_userptr_blits
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_exec_balancer
results: parsing output: 138/ for test: gem_gtt_cpu_tlb
results: parsing output: 139/ for test: kms_ccs
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: syncobj_basic
results: parsing output: 142/ for test: kms_atomic_transition
results: parsing output: 143/ for test: syncobj_timeline
results: parsing output: 144/ for test: kms_vblank
results: parsing output: 145/ for test: gem_exec_balancer
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: gem_userptr_blits
results: parsing output: 149/ for test: gem_exec_reloc
results: parsing output: 150/ for test: kms_lease
results: parsing output: 151/ for test: kms_plane
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: gem_exec_reloc
results: parsing output: 154/ for test: gem_set_tiling_vs_blt
results: parsing output: 155/ for test: gem_exec_schedule
Done.