[71.452379] Initializing watchdogs
[71.452425]   /dev/watchdog0
[71.467135] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[71.471099] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.473198] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.476525] [001/154] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[71.584596] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[71.589074] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[71.680152] [002/154] (960s left) kms_content_protection (srm)
[71.807824] Starting subtest: srm
[71.814955] Subtest srm: SKIP (0.003s)
[71.962640] [003/154] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[72.043814] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[72.047833] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[72.161355] [004/154] (959s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[72.254635] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[72.259260] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[72.531771] [005/154] (959s left) gem_userptr_blits (probe)
[72.651684] Starting subtest: probe
[72.819785] Subtest probe: SUCCESS (0.167s)
[73.094299] [006/154] (959s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[73.222674] Starting subtest: stress-xrgb8888-xtiled
[79.154254] Subtest stress-xrgb8888-xtiled: SUCCESS (5.936s)
[79.202059] [007/154] (953s left) kms_cursor_legacy (torture-bo)
[79.309791] Starting subtest: torture-bo
[79.311399] Starting dynamic subtest: pipe-A
[85.564256] Dynamic subtest pipe-A: SUCCESS (6.253s)
[85.581905] Starting dynamic subtest: pipe-B
[91.999800] Dynamic subtest pipe-B: SUCCESS (6.434s)
[92.009066] Starting dynamic subtest: pipe-C
[97.987797] Dynamic subtest pipe-C: SUCCESS (5.986s)
[98.006297] Starting dynamic subtest: pipe-D
[104.425675] Dynamic subtest pipe-D: SUCCESS (6.436s)
[104.435871] Starting dynamic subtest: all-pipes
[110.945535] Dynamic subtest all-pipes: SUCCESS (6.498s)
[110.949641] Subtest torture-bo: SUCCESS (31.613s)
[111.080767] [008/154] (921s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[111.136955] Starting subtest: multi-wait-for-submit-unsubmitted
[111.242628] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[111.314987] [009/154] (921s left) gem_exec_schedule (u-lateslice)
[111.384916] Starting subtest: u-lateslice
[111.387059] Starting dynamic subtest: rcs0
[111.393838] Dynamic subtest rcs0: SUCCESS (0.021s)
[111.401791] Starting dynamic subtest: bcs0
[111.411438] Dynamic subtest bcs0: SUCCESS (0.018s)
[111.419265] Starting dynamic subtest: vcs0
[111.428582] Dynamic subtest vcs0: SUCCESS (0.017s)
[111.436711] Starting dynamic subtest: vcs1
[111.446512] Dynamic subtest vcs1: SUCCESS (0.018s)
[111.456929] Starting dynamic subtest: vecs0
[111.464574] Dynamic subtest vecs0: SUCCESS (0.018s)
[111.472696] Starting dynamic subtest: ccs0
[111.483550] Dynamic subtest ccs0: SUCCESS (0.019s)
[111.486141] Subtest u-lateslice: SUCCESS (0.111s)
[113.306901] [010/154] (919s left) gem_userptr_blits (map-fixed-invalidate-busy)
[113.364196] Starting subtest: map-fixed-invalidate-busy
[113.368717] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[113.477569] [011/154] (918s left) kms_async_flips (test-time-stamp-atomic)
[113.561624] Starting subtest: test-time-stamp-atomic
[114.664613] Starting dynamic subtest: pipe-A-eDP-1
[115.145419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[115.524144] Starting dynamic subtest: pipe-B-eDP-1
[116.378724] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.859s)
[116.759443] Starting dynamic subtest: pipe-C-eDP-1
[117.614379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.861s)
[117.976954] Starting dynamic subtest: pipe-D-eDP-1
[118.744310] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[118.746887] Subtest test-time-stamp-atomic: SUCCESS (5.183s)
[119.896804] [012/154] (912s left) gen9_exec_parse (bb-secure)
[119.956329] Subtest bb-secure: SKIP (0.000s)
[120.026799] [013/154] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[120.105467] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[127.431290] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.332s)
[127.575175] [014/154] (904s left) kms_vblank (query-idle-hang)
[127.650252] Starting subtest: query-idle-hang
[127.652533] Starting dynamic subtest: pipe-A-eDP-1
[154.055320] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.405s)
[154.068898] Starting dynamic subtest: pipe-D-eDP-1
[168.961692] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.901s)
[168.964077] Subtest query-idle-hang: SUCCESS (41.311s)
[169.789605] [015/154] (862s left) kms_chamelium_edid (hdmi-mode-timings)
[170.167547] Subtest hdmi-mode-timings: SKIP (0.000s)
[170.999163] [016/154] (861s left) kms_cursor_crc (cursor-suspend)
[171.105771] Starting subtest: cursor-suspend
[171.107684] Starting dynamic subtest: pipe-A-eDP-1
[203.644685] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.338s)
[203.654379] Starting dynamic subtest: pipe-D-eDP-1
[237.621024] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.844s)
[237.623347] Subtest cursor-suspend: SUCCESS (7.184s)
[238.448987] [017/154] (794s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[238.500121] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[238.502357] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[238.601072] [018/154] (794s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[238.677121] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[238.681056] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[238.769922] [019/154] (793s left) kms_flip (absolute-wf_vblank-interruptible)
[238.850891] Starting subtest: absolute-wf_vblank-interruptible
[238.853152] Starting dynamic subtest: A-eDP1
[247.548240] Dynamic subtest A-eDP1: SUCCESS (8.752s)
[247.559313] Starting dynamic subtest: B-eDP1
[256.269607] Dynamic subtest B-eDP1: SUCCESS (8.740s)
[256.279250] Starting dynamic subtest: C-eDP1
[264.973163] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[264.983457] Starting dynamic subtest: D-eDP1
[273.696233] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[273.698667] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.934s)
[274.903954] [020/154] (757s left) sriov_basic (enable-vfs-autoprobe-on)
[274.956213] Starting subtest: enable-vfs-autoprobe-on
[274.958520] Starting dynamic subtest: numvfs-1
[274.963112] Dynamic subtest numvfs-1: SKIP (0.000s)
[274.972215] Starting dynamic subtest: numvfs-2
[274.976305] Dynamic subtest numvfs-2: SKIP (0.000s)
[274.984569] Starting dynamic subtest: numvfs-3
[274.988782] Dynamic subtest numvfs-3: SKIP (0.000s)
[274.996845] Starting dynamic subtest: numvfs-4
[275.000905] Dynamic subtest numvfs-4: SKIP (0.000s)
[275.008983] Starting dynamic subtest: numvfs-5
[275.013060] Dynamic subtest numvfs-5: SKIP (0.000s)
[275.022439] Starting dynamic subtest: numvfs-6
[275.027153] Dynamic subtest numvfs-6: SKIP (0.000s)
[275.038974] Starting dynamic subtest: numvfs-7
[275.043551] Dynamic subtest numvfs-7: SKIP (0.000s)
[275.053878] Starting dynamic subtest: numvfs-random
[275.058241] Dynamic subtest numvfs-random: SKIP (0.000s)
[275.067255] Starting dynamic subtest: numvfs-all
[275.071426] Dynamic subtest numvfs-all: SKIP (0.000s)
[275.075481] Subtest enable-vfs-autoprobe-on: SKIP (0.009s)
[275.110695] [021/154] (757s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[275.186675] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[275.832931] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[275.993706] [022/154] (756s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[276.076967] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[276.081320] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[276.170307] [023/154] (756s left) kms_chamelium_color (ctm-blue-to-red)
[276.240529] Subtest ctm-blue-to-red: SKIP (0.000s)
[276.283155] [024/154] (756s left) i915_pm_rpm (gem-execbuf)
[277.780314] Starting subtest: gem-execbuf
[277.783233] Starting dynamic subtest: smem0
[279.529192] Dynamic subtest smem0: SUCCESS (1.749s)
[279.531942] Subtest gem-execbuf: SUCCESS (1.751s)
[279.615522] [025/154] (753s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[279.704913] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[279.708865] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.794404] [026/154] (753s left) syncobj_wait (multi-wait-submitted-signaled)
[279.854904] Starting subtest: multi-wait-submitted-signaled
[279.857248] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[279.939966] [027/154] (753s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[280.023075] Starting subtest: 4-tiled-64bpp-rotate-0
[281.579599] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.557s)
[281.737056] [028/154] (751s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[281.812469] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[281.816522] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[281.900186] [029/154] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[281.977669] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[281.981475] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[282.077583] [030/154] (751s left) kms_psr (psr-suspend)
[282.154122] Starting subtest: psr-suspend
[282.156126] Starting dynamic subtest: eDP-1
[300.618967] Dynamic subtest eDP-1: SUCCESS (2.982s)
[300.621793] Subtest psr-suspend: SUCCESS (2.983s)
[301.446737] [031/154] (731s left) syncobj_wait (invalid-signal-illegal-handle)
[301.503445] Starting subtest: invalid-signal-illegal-handle
[301.506170] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[301.589009] [032/154] (731s left) gem_render_tiled_blits (basic)
[301.644758] Subtest basic: SKIP (0.000s)
[301.714336] [033/154] (731s left) gem_mmap_wc (bad-offset)
[301.770393] Subtest bad-offset: SKIP (0.000s)
[301.828351] [034/154] (731s left) syncobj_basic (bad-destroy-pad)
[301.877908] Starting subtest: bad-destroy-pad
[301.880776] Subtest bad-destroy-pad: SUCCESS (0.000s)
[301.980491] [035/154] (731s left) gem_exec_whisper (basic-queues-forked-all)
[302.034972] Starting subtest: basic-queues-forked-all
[322.319984] Subtest basic-queues-forked-all: SUCCESS (20.367s)
[322.498477] [036/154] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[322.591030] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[329.125165] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.547s)
[329.226611] [037/154] (704s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[329.300762] Starting subtest: plane-lut1d-ctm3x4
[329.445864] Starting dynamic subtest: pipe-A-plane-0
[329.612394] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[329.622509] Starting dynamic subtest: pipe-A-plane-1
[329.767809] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[329.778072] Starting dynamic subtest: pipe-A-plane-2
[329.923303] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[331.207016] Starting dynamic subtest: pipe-B-plane-0
[331.354388] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[331.365249] Starting dynamic subtest: pipe-B-plane-1
[331.509892] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[331.520350] Starting dynamic subtest: pipe-B-plane-2
[331.677212] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[332.895912] Starting dynamic subtest: pipe-C-plane-0
[333.030559] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[333.043813] Starting dynamic subtest: pipe-C-plane-1
[333.174926] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[333.185958] Starting dynamic subtest: pipe-C-plane-2
[333.324092] Dynamic subtest pipe-C-plane-2: SUCCESS (0.145s)
[334.524425] Starting dynamic subtest: pipe-D-plane-0
[334.659304] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[334.672182] Starting dynamic subtest: pipe-D-plane-1
[334.825801] Dynamic subtest pipe-D-plane-1: SUCCESS (0.164s)
[334.836524] Starting dynamic subtest: pipe-D-plane-2
[334.959946] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[335.248961] Subtest plane-lut1d-ctm3x4: SUCCESS (5.950s)
[336.073993] [038/154] (697s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[336.160190] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[336.165130] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.246003] [039/154] (697s left) kms_setmode (basic)
[336.296076] Starting subtest: basic
[336.618077] Starting dynamic subtest: pipe-A-eDP-1
[338.697164] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[339.039920] Starting dynamic subtest: pipe-B-eDP-1
[341.129929] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.092s)
[341.439335] Subtest basic: SUCCESS (5.139s)
[342.271486] [040/154] (691s left) kms_frontbuffer_tracking (basic)
[342.355820] Starting subtest: basic
[345.640684] Subtest basic: SUCCESS (3.290s)
[345.720591] [041/154] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[345.803912] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[345.808012] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[345.894401] [042/154] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[345.975044] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[345.979343] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[346.083506] [043/154] (687s left) api_intel_allocator (reserve-simple)
[346.133012] Starting subtest: reserve-simple
[346.135173] Subtest reserve-simple: SUCCESS (0.004s)
[346.243549] [044/154] (687s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[346.304861] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[346.306923] Starting dynamic subtest: pipe-A-eDP-1
[346.324344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[346.334314] Starting dynamic subtest: pipe-B-eDP-1
[346.353693] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.362887] Starting dynamic subtest: pipe-C-eDP-1
[346.382155] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[346.392419] Starting dynamic subtest: pipe-D-eDP-1
[346.412495] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[346.414875] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[348.638458] [045/154] (685s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[348.741742] Starting subtest: cursorA-vs-flipA-toggle
[359.868182] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.128s)
[360.676963] [046/154] (673s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[360.769353] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[360.773879] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[360.866630] [047/154] (672s left) kms_legacy_colorkey (invalid-plane)
[360.941681] Starting subtest: invalid-plane
[360.944183] Starting dynamic subtest: zero-id
[360.946897] Dynamic subtest zero-id: SUCCESS (0.000s)
[360.957170] Starting dynamic subtest: outrange-id
[360.959511] Dynamic subtest outrange-id: SUCCESS (0.000s)
[360.961788] Subtest invalid-plane: SUCCESS (0.001s)
[361.013855] [048/154] (672s left) gem_mmap_gtt (basic-small-bo)
[361.059003] Subtest basic-small-bo: SKIP (0.000s)
[361.110765] [049/154] (672s left) syncobj_eventfd (timeline-wait-before-signal)
[361.166949] Starting subtest: timeline-wait-before-signal
[361.197439] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[361.287569] [050/154] (672s left) gem_mmap_offset (oob-read)
[361.346478] Starting subtest: oob-read
[361.348994] Subtest oob-read: SUCCESS (0.000s)
[361.443177] [051/154] (672s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[361.527818] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[361.532138] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.631611] [052/154] (672s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[361.687053] Starting subtest: single-wait-all-for-submit-available-signaled
[361.689946] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[361.787852] [053/154] (672s left) perf (gen8-unprivileged-single-ctx-counters)
[361.903690] Starting subtest: gen8-unprivileged-single-ctx-counters
[361.908021] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[361.946742] [054/154] (672s left) gem_partial_pwrite_pread (write-uncached)
[361.998332] Subtest write-uncached: SKIP (0.000s)
[362.065303] [055/154] (672s left) gem_exec_whisper (basic-fds)
[362.120023] Starting subtest: basic-fds
[368.196016] Subtest basic-fds: SUCCESS (6.073s)
[368.376592] [056/154] (665s left) prime_vgem (basic-gtt)
[368.521373] Starting subtest: basic-gtt
[368.526972] Subtest basic-gtt: SKIP (0.000s)
[368.607170] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[368.610064] [057/154] (665s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[368.693161] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[368.698156] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[368.777347] [058/154] (665s left) kms_cursor_crc (cursor-sliding-128x128)
[368.959340] Starting subtest: cursor-sliding-128x128
[368.961627] Starting dynamic subtest: pipe-A-eDP-1
[372.208338] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.247s)
[372.238916] Starting dynamic subtest: pipe-D-eDP-1
[376.070654] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.844s)
[376.073369] Subtest cursor-sliding-128x128: SUCCESS (7.116s)
[376.943464] [059/154] (657s left) kms_big_fb (linear-16bpp-rotate-90)
[377.027728] Starting subtest: linear-16bpp-rotate-90
[377.047670] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[377.165504] [060/154] (657s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[377.234739] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[377.239953] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[377.338208] [061/154] (657s left) syncobj_timeline (multi-wait-available-signaled)
[377.392158] Starting subtest: multi-wait-available-signaled
[377.394996] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[377.498862] [062/154] (656s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[377.572698] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[377.577714] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[377.666069] [063/154] (656s left) gem_exec_schedule (deep)
[377.839143] Starting subtest: deep
[377.841884] Starting dynamic subtest: rcs0
[382.712161] Dynamic subtest rcs0: SKIP (4.873s)
[382.725895] Starting dynamic subtest: vcs0
[392.798247] Dynamic subtest vcs0: SUCCESS (10.090s)
[392.812578] Starting dynamic subtest: vcs1
[403.487312] Dynamic subtest vcs1: SUCCESS (10.687s)
[403.501132] Starting dynamic subtest: vecs0
[414.129080] Dynamic subtest vecs0: SUCCESS (10.637s)
[414.141122] Starting dynamic subtest: ccs0
[425.529260] Dynamic subtest ccs0: SUCCESS (11.394s)
[425.532840] Subtest deep: SUCCESS (47.687s)
[426.827877] [064/154] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[426.917855] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[426.923037] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[427.025391] [065/154] (607s left) kms_flip (dpms-vs-vblank-race)
[427.097857] Starting subtest: dpms-vs-vblank-race
[427.099933] Starting dynamic subtest: A-eDP1
[431.027246] Dynamic subtest A-eDP1: SUCCESS (3.929s)
[431.038397] Starting dynamic subtest: B-eDP1
[434.615690] Dynamic subtest B-eDP1: SUCCESS (3.588s)
[434.626602] Starting dynamic subtest: C-eDP1
[438.124891] Dynamic subtest C-eDP1: SUCCESS (3.507s)
[438.135163] Starting dynamic subtest: D-eDP1
[442.775052] Dynamic subtest D-eDP1: SUCCESS (4.647s)
[442.778115] Subtest dpms-vs-vblank-race: SUCCESS (15.682s)
[443.646584] [066/154] (590s left) gem_exec_fence (syncobj-invalid-wait)
[444.114171] Starting subtest: syncobj-invalid-wait
[444.117077] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[445.175573] [067/154] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[445.265024] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[453.869402] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.613s)
[453.976067] [068/154] (580s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[454.058875] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[454.063005] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[454.150391] [069/154] (580s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[454.223977] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[454.229151] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[454.295848] [070/154] (580s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[454.379201] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[458.345131] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.973s)
[459.525463] [071/154] (575s left) gem_readwrite (read-write)
[459.585717] Subtest read-write: SKIP (0.000s)
[459.647318] [072/154] (575s left) api_intel_bb (object-noreloc-keep-cache-simple)
[459.704088] Starting subtest: object-noreloc-keep-cache-simple
[459.707128] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[459.795752] [073/154] (575s left) gem_exec_reloc (basic-wc-read-noreloc)
[459.863419] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[459.938353] [074/154] (575s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[460.020627] Starting subtest: bad-aux-stride-y-tiled-ccs
[460.022928] Starting dynamic subtest: pipe-A-eDP-1
[460.048289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.060079] Starting dynamic subtest: pipe-B-eDP-1
[460.085890] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.095938] Starting dynamic subtest: pipe-C-eDP-1
[460.122129] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.134056] Starting dynamic subtest: pipe-D-eDP-1
[460.160727] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[460.165738] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[462.282497] [075/154] (572s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[462.331426] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[462.334159] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[462.448031] [076/154] (572s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[462.518720] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[462.521122] Starting dynamic subtest: pipe-A-eDP-1
[462.545201] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[462.557386] Starting dynamic subtest: pipe-B-eDP-1
[462.582175] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[462.591988] Starting dynamic subtest: pipe-C-eDP-1
[462.616678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[462.626337] Starting dynamic subtest: pipe-D-eDP-1
[462.649604] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[462.653863] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[464.843261] [077/154] (570s left) gem_render_copy (y-tiled-to-vebox-linear)
[464.891780] Starting subtest: y-tiled-to-vebox-linear
[464.897148] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[465.075667] [078/154] (570s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[465.143482] Starting subtest: async-flip-with-page-flip-events-tiled
[465.514922] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[468.331313] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[468.344849] Starting dynamic subtest: pipe-A-eDP-1-4
[470.505760] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[470.516449] Starting dynamic subtest: pipe-A-eDP-1-4
[472.514795] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[472.526169] Starting dynamic subtest: pipe-A-eDP-1-x
[474.694756] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[475.059801] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[477.850506] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[477.861797] Starting dynamic subtest: pipe-B-eDP-1-4
[480.024365] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[480.036073] Starting dynamic subtest: pipe-B-eDP-1-4
[482.033564] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[482.044139] Starting dynamic subtest: pipe-B-eDP-1-x
[484.223798] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[484.619878] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[487.381476] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[487.395307] Starting dynamic subtest: pipe-C-eDP-1-4
[489.543928] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[489.555042] Starting dynamic subtest: pipe-C-eDP-1-4
[491.553544] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[491.567435] Starting dynamic subtest: pipe-C-eDP-1-x
[493.732152] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[494.098821] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[496.912315] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.823s)
[496.924153] Starting dynamic subtest: pipe-D-eDP-1-4
[499.074050] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s)
[499.084682] Starting dynamic subtest: pipe-D-eDP-1-4
[501.083918] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[501.095138] Starting dynamic subtest: pipe-D-eDP-1-x
[503.262429] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[503.265168] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.128s)
[504.490440] [079/154] (530s left) gem_exec_schedule (noreorder-corked)
[504.664520] Starting subtest: noreorder-corked
[504.667037] Starting dynamic subtest: rcs0
[505.800281] Dynamic subtest rcs0: SUCCESS (1.136s)
[505.812150] Starting dynamic subtest: vcs0
[507.105773] Dynamic subtest vcs0: SUCCESS (1.302s)
[507.120951] Starting dynamic subtest: vcs1
[509.084637] Dynamic subtest vcs1: SUCCESS (1.977s)
[509.098489] Starting dynamic subtest: vecs0
[511.072931] Dynamic subtest vecs0: SUCCESS (1.986s)
[511.086408] Starting dynamic subtest: ccs0
[512.229256] Dynamic subtest ccs0: SUCCESS (1.156s)
[512.232035] Subtest noreorder-corked: SUCCESS (7.568s)
[512.414557] [080/154] (522s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[512.502171] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[512.507701] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[512.609071] [081/154] (522s left) kms_frontbuffer_tracking (fbchdr-stridechange)
[512.686293] Starting subtest: fbchdr-stridechange
[512.691416] Subtest fbchdr-stridechange: SKIP (0.000s)
[512.774442] [082/154] (522s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[512.853405] Starting subtest: bo-too-small-due-to-tiling
[512.858887] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[512.956148] [083/154] (522s left) prime_mmap (test_forked)
[513.012296] Starting subtest: test_forked
[513.014781] Starting dynamic subtest: test_forked-smem
[513.053044] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[513.056167] Subtest test_forked: SUCCESS (0.042s)
[513.145860] [084/154] (522s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[513.196018] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[513.256694] [085/154] (522s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[513.334046] Starting subtest: fbc-rgb565-draw-pwrite
[517.884659] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.558s)
[519.081059] [086/154] (516s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[519.151422] Starting subtest: plane-upscale-20x20-with-modifiers
[519.154192] Starting dynamic subtest: pipe-A
[519.488496] Dynamic subtest pipe-A: SUCCESS (0.339s)
[519.498650] Starting dynamic subtest: pipe-B
[520.871344] Dynamic subtest pipe-B: SUCCESS (1.381s)
[520.885681] Starting dynamic subtest: pipe-C
[522.299834] Dynamic subtest pipe-C: SUCCESS (1.428s)
[522.310087] Starting dynamic subtest: pipe-D
[523.734116] Dynamic subtest pipe-D: SUCCESS (1.434s)
[523.737035] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.587s)
[524.915328] [087/154] (510s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[525.004862] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[525.009660] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[525.107845] [088/154] (510s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[525.196790] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[525.201791] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[525.273321] [089/154] (510s left) gem_partial_pwrite_pread (reads)
[525.333128] Subtest reads: SKIP (0.000s)
[525.405262] [090/154] (510s left) gem_exec_balancer (bonded-chain)
[525.459155] Starting subtest: bonded-chain
[532.453636] Subtest bonded-chain: SUCCESS (6.990s)
[532.764689] [091/154] (502s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[532.846389] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[532.849168] Starting dynamic subtest: A-eDP1
[541.762811] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[541.773660] Starting dynamic subtest: B-eDP1
[550.694889] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[550.708868] Starting dynamic subtest: C-eDP1
[559.614880] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[559.627142] Starting dynamic subtest: D-eDP1
[568.539749] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[568.545423] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.690s)
[569.773311] [092/154] (465s left) kms_getfb (getfb-reject-nv12)
[569.851701] Starting subtest: getfb-reject-nv12
[569.854146] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[569.956301] [093/154] (465s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[570.040658] Starting subtest: psr-farfromfence-mmap-gtt
[570.045575] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[570.166027] [094/154] (465s left) gem_ctx_persistence (many-contexts)
[570.219422] Starting subtest: many-contexts
[615.382708] Subtest many-contexts: SUCCESS (45.161s)
[615.464367] [095/154] (420s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[615.536931] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[615.541963] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[615.612930] [096/154] (420s left) kms_psr (psr-cursor-plane-onoff)
[615.687170] Starting subtest: psr-cursor-plane-onoff
[615.689551] Starting dynamic subtest: eDP-1
[617.460657] Dynamic subtest eDP-1: SUCCESS (1.774s)
[617.463563] Subtest psr-cursor-plane-onoff: SUCCESS (1.775s)
[618.314665] [097/154] (417s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[618.367017] Subtest no-spare-fences-busy: SKIP (0.000s)
[618.438838] [098/154] (417s left) kms_plane_multiple (tiling-x)
[618.510461] Starting subtest: tiling-x
[618.512972] Starting dynamic subtest: pipe-A-eDP-1
[622.359461] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.848s)
[622.370358] Starting dynamic subtest: pipe-B-eDP-1
[626.997305] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.637s)
[627.008144] Starting dynamic subtest: pipe-C-eDP-1
[631.344928] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.345s)
[631.356245] Starting dynamic subtest: pipe-D-eDP-1
[635.821540] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.478s)
[635.824051] Subtest tiling-x: SUCCESS (17.313s)
[636.627749] [099/154] (399s left) kms_vblank (query-busy-hang)
[636.701429] Starting subtest: query-busy-hang
[636.703877] Starting dynamic subtest: pipe-A-eDP-1
[662.892423] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.191s)
[662.908681] Starting dynamic subtest: pipe-D-eDP-1
[677.877436] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.984s)
[677.880146] Subtest query-busy-hang: SUCCESS (41.180s)
[678.684487] [100/154] (357s left) gem_madvise (dontneed-before-pwrite)
[678.724517] Starting subtest: dontneed-before-pwrite
[678.740026] Subtest dontneed-before-pwrite: SKIP (0.016s)
[678.803715] [101/154] (357s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[678.876776] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[678.881797] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[678.978044] [102/154] (357s left) gem_exec_flush (basic-uc-prw-default)
[679.045397] Starting subtest: basic-uc-prw-default
[684.501211] Subtest basic-uc-prw-default: SUCCESS (5.457s)
[684.689631] [103/154] (351s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[684.785538] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[684.790300] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[684.871656] [104/154] (351s left) gem_exec_balancer (parallel-contexts)
[685.131768] Starting subtest: parallel-contexts
[687.598628] Subtest parallel-contexts: SUCCESS (2.470s)
[687.713700] [105/154] (348s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[687.802139] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[695.223159] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.428s)
[695.345804] [106/154] (341s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[695.419556] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[695.421887] Starting dynamic subtest: pipe-A-eDP-1
[695.431847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[695.442600] Starting dynamic subtest: pipe-B-eDP-1
[695.453038] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[695.463827] Starting dynamic subtest: pipe-C-eDP-1
[695.474367] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[695.484436] Starting dynamic subtest: pipe-D-eDP-1
[695.494380] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[695.499012] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[697.693103] [107/154] (338s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[697.775675] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[697.783936] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[697.863044] [108/154] (338s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[697.942289] Starting subtest: hdr-rgb101010-draw-pwrite
[697.946974] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[698.041710] [109/154] (338s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[698.088665] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[698.195292] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[698.271440] [110/154] (338s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[698.353878] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[698.359456] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[698.452603] [111/154] (338s left) gem_exec_capture (capture-invisible)
[698.510964] Starting subtest: capture-invisible
[698.513902] Starting dynamic subtest: smem0
[698.519095] Dynamic subtest smem0: SKIP (0.000s)
[698.524168] Subtest capture-invisible: SKIP (0.001s)
[698.620834] [112/154] (337s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[698.692923] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[698.697711] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[698.770030] [113/154] (337s left) perf (polling-small-buf)
[698.859964] Starting subtest: polling-small-buf
[698.953128] Subtest polling-small-buf: SUCCESS (0.092s)
[699.004330] [114/154] (337s left) fbdev (nullptr)
[699.043171] Starting subtest: nullptr
[699.046148] Subtest nullptr: SUCCESS (0.000s)
[699.102952] [115/154] (337s left) gen9_exec_parse (unaligned-access)
[699.162002] Subtest unaligned-access: SKIP (0.000s)
[699.242515] [116/154] (337s left) kms_addfb_basic (basic)
[699.300561] Starting subtest: basic
[699.302451] Subtest basic: SUCCESS (0.000s)
[699.412564] [117/154] (337s left) kms_cursor_crc (cursor-onscreen-64x21)
[699.571567] Starting subtest: cursor-onscreen-64x21
[699.618756] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[699.859681] [118/154] (337s left) dumb_buffer (map-uaf)
[699.903019] Starting subtest: map-uaf
[699.905063] Subtest map-uaf: SUCCESS (0.005s)
[700.003800] [119/154] (336s left) kms_psr (pr-primary-mmap-gtt)
[700.081728] Starting subtest: pr-primary-mmap-gtt
[700.086463] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[700.155857] [120/154] (336s left) sw_sync (sync_busy_fork)
[700.192561] Starting subtest: sync_busy_fork
[701.197853] Subtest sync_busy_fork: SUCCESS (1.010s)
[701.261330] [121/154] (335s left) kms_psr (fbc-psr-dpms)
[701.326795] Starting subtest: fbc-psr-dpms
[701.329404] Starting dynamic subtest: eDP-1
[701.334790] Dynamic subtest eDP-1: SKIP (0.000s)
[701.340128] Subtest fbc-psr-dpms: SKIP (0.001s)
[701.402785] [122/154] (335s left) kms_psr (fbc-pr-cursor-render)
[701.480123] Starting subtest: fbc-pr-cursor-render
[701.485119] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[701.554959] [123/154] (335s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[701.639976] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[701.644994] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[701.752652] [124/154] (335s left) i915_selftest (live)
[706.410327] Starting subtest: live
[706.412996] Starting dynamic subtest: sanitycheck
[711.649554] Dynamic subtest sanitycheck: SUCCESS (5.239s)
[711.660485] Starting dynamic subtest: uncore
[715.249447] Dynamic subtest uncore: SUCCESS (3.599s)
[715.259712] Starting dynamic subtest: workarounds
[719.291726] Dynamic subtest workarounds: SUCCESS (4.041s)
[719.301773] Starting dynamic subtest: gt_engines
[723.291181] Dynamic subtest gt_engines: SUCCESS (3.998s)
[723.301503] Starting dynamic subtest: gt_timelines
[739.292366] Dynamic subtest gt_timelines: SUCCESS (16.002s)
[739.303671] Starting dynamic subtest: gt_contexts
[742.916137] Dynamic subtest gt_contexts: SUCCESS (3.622s)
[742.927413] Starting dynamic subtest: gt_lrc
[749.920161] Dynamic subtest gt_lrc: SUCCESS (7.004s)
[749.930600] Starting dynamic subtest: gt_mocs
[755.239064] Dynamic subtest gt_mocs: SUCCESS (5.317s)
[755.250525] Starting dynamic subtest: gt_pm
[760.912763] Dynamic subtest gt_pm: SUCCESS (5.674s)
[760.925952] Starting dynamic subtest: gt_heartbeat
[764.587628] Dynamic subtest gt_heartbeat: SUCCESS (3.674s)
[764.597592] Starting dynamic subtest: gt_tlb
[774.905911] Dynamic subtest gt_tlb: SUCCESS (10.318s)
[774.915974] Starting dynamic subtest: requests
[787.359460] Dynamic subtest requests: SUCCESS (12.448s)
[787.371361] Starting dynamic subtest: migrate
[794.009134] Dynamic subtest migrate: SUCCESS (6.644s)
[794.020549] Starting dynamic subtest: active
[799.269950] Dynamic subtest active: SUCCESS (5.256s)
[799.281379] Starting dynamic subtest: objects
[803.527179] Dynamic subtest objects: SUCCESS (4.252s)
[803.537560] Starting dynamic subtest: mman
[807.736677] Dynamic subtest mman: SUCCESS (4.206s)
[807.748159] Starting dynamic subtest: dmabuf
[811.373916] Dynamic subtest dmabuf: SUCCESS (3.633s)
[811.385643] Starting dynamic subtest: vma
[814.975769] Dynamic subtest vma: SUCCESS (3.599s)
[814.992713] Starting dynamic subtest: coherency
[819.290392] Dynamic subtest coherency: SUCCESS (4.310s)
[819.300637] Starting dynamic subtest: gtt
[829.307368] Dynamic subtest gtt: SUCCESS (10.011s)
[829.324004] Starting dynamic subtest: gem
[835.813572] Dynamic subtest gem: SUCCESS (6.503s)
[835.824873] Starting dynamic subtest: evict
[840.622704] Dynamic subtest evict: SUCCESS (4.806s)
[840.633424] Starting dynamic subtest: hugepages
[852.258525] Dynamic subtest hugepages: SUCCESS (11.631s)
[852.270020] Starting dynamic subtest: gem_contexts
[879.012302] Dynamic subtest gem_contexts: SUCCESS (26.748s)
[879.022868] Starting dynamic subtest: client
[882.711836] Dynamic subtest client: SUCCESS (3.697s)
[882.722047] Starting dynamic subtest: gem_migrate
[886.335721] Dynamic subtest gem_migrate: SUCCESS (3.622s)
[886.350094] Starting dynamic subtest: reset
[890.038799] Dynamic subtest reset: SUCCESS (3.699s)
[890.049697] Starting dynamic subtest: memory_region
[893.703530] Dynamic subtest memory_region: SUCCESS (3.662s)
[893.717855] Starting dynamic subtest: hangcheck
[907.768135] Dynamic subtest hangcheck: SUCCESS (14.061s)
[907.778907] Starting dynamic subtest: execlists
[911.398622] Dynamic subtest execlists: SUCCESS (3.629s)
[911.410521] Starting dynamic subtest: ring_submission
[915.020229] Dynamic subtest ring_submission: SUCCESS (3.620s)
[915.036983] Starting dynamic subtest: perf
[918.688860] Dynamic subtest perf: SUCCESS (3.667s)
[918.704045] Starting dynamic subtest: slpc
[933.667345] Dynamic subtest slpc: SUCCESS (14.977s)
[933.679205] Starting dynamic subtest: guc
[938.373539] Dynamic subtest guc: SUCCESS (4.703s)
[938.384689] Starting dynamic subtest: guc_multi_lrc
[941.982444] Dynamic subtest guc_multi_lrc: SUCCESS (3.607s)
[941.994440] Starting dynamic subtest: guc_hang
[946.292659] Dynamic subtest guc_hang: SUCCESS (4.309s)
[946.303964] Starting dynamic subtest: late_gt_pm
[949.921833] Dynamic subtest late_gt_pm: SUCCESS (3.628s)
[949.924824] Subtest live: SUCCESS (243.480s)
[949.953065] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[949.953966] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[949.957799] [125/154] ( 87s left) kms_dsc (dsc-with-bpc-formats)
[952.378742] Starting subtest: dsc-with-bpc-formats
[952.506751] Subtest dsc-with-bpc-formats: SKIP (0.004s)
[952.540870] [FACT kms_dsc (dsc-with-bpc-formats)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[952.541913] [FACT kms_dsc (dsc-with-bpc-formats)] new: kernel.kmod_is_loaded.i915: true
[952.546417] [126/154] ( 84s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[952.619967] Starting subtest: fbc-psr2-sprite-mmap-gtt
[952.622892] Starting dynamic subtest: eDP-1
[952.628025] Dynamic subtest eDP-1: SKIP (0.000s)
[952.633624] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[952.692672] [127/154] ( 84s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[952.770007] Starting subtest: fbcpsr-rgb565-draw-render
[959.885317] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.121s)
[960.021075] [128/154] ( 77s left) gem_create (hog-create)
[960.073921] Starting subtest: hog-create
[960.076576] Starting dynamic subtest: smem0
[994.086992] Dynamic subtest smem0: SUCCESS (34.012s)
[994.090310] Subtest hog-create: SUCCESS (34.014s)
[994.275486] [129/154] ( 43s left) kms_pm_rpm (fences-dpms)
[996.205969] Starting subtest: fences-dpms
[996.211864] Subtest fences-dpms: SKIP (0.000s)
[996.583601] [130/154] ( 40s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[996.661987] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[996.667300] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[996.752620] [131/154] ( 40s left) kms_invalid_mode (bad-vtotal)
[996.829027] Starting subtest: bad-vtotal
[996.832018] Starting dynamic subtest: pipe-A-eDP-1
[997.114145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[997.125143] Starting dynamic subtest: pipe-B-eDP-1
[997.127571] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[997.138058] Starting dynamic subtest: pipe-C-eDP-1
[997.140848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[997.151121] Starting dynamic subtest: pipe-D-eDP-1
[997.153933] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[997.156634] Subtest bad-vtotal: SUCCESS (0.295s)
[997.930371] [132/154] ( 39s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[998.004086] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[998.006945] Starting dynamic subtest: pipe-A
[999.242421] Dynamic subtest pipe-A: SUCCESS (1.241s)
[999.252948] Starting dynamic subtest: pipe-B
[1001.525763] Dynamic subtest pipe-B: SUCCESS (2.282s)
[1001.537885] Starting dynamic subtest: pipe-C
[1002.719129] Dynamic subtest pipe-C: SUCCESS (1.192s)
[1002.729132] Starting dynamic subtest: pipe-D
[1003.948203] Dynamic subtest pipe-D: SUCCESS (1.228s)
[1003.951018] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.947s)
[1005.147708] [133/154] ( 32s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[1005.198133] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[1005.203836] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[1005.382130] [134/154] ( 32s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[1005.452947] Starting subtest: flip-vs-dpms-off-vs-modeset
[1005.455714] Starting dynamic subtest: A-eDP1
[1009.067181] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[1009.079150] Starting dynamic subtest: B-eDP1
[1012.272937] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[1012.284504] Starting dynamic subtest: C-eDP1
[1015.492793] Dynamic subtest C-eDP1: SUCCESS (3.219s)
[1015.503138] Starting dynamic subtest: D-eDP1
[1018.707153] Dynamic subtest D-eDP1: SUCCESS (3.215s)
[1018.709939] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.258s)
[1019.516645] [135/154] ( 18s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[1019.578794] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[1019.639967] [136/154] ( 17s left) gem_softpin (allocator-nopin)
[1019.697309] Starting subtest: allocator-nopin
[1019.787408] Subtest allocator-nopin: SUCCESS (0.090s)
[1019.906234] [137/154] ( 17s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[1020.274913] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[1021.129090] [138/154] ( 16s left) gem_userptr_blits (relocations)
[1021.193972] Starting subtest: relocations
[1021.198688] Subtest relocations: SKIP (0.001s)
[1021.308438] [139/154] ( 16s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[1021.385725] Starting subtest: x-tiled-64bpp-rotate-270
[1021.405674] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[1021.506893] [140/154] ( 16s left) gem_eio (in-flight-external)
[1021.721038] Starting subtest: in-flight-external
[1023.152791] Subtest in-flight-external: SUCCESS (1.432s)
[1023.298512] [141/154] ( 14s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[1023.381092] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[1023.383761] Starting dynamic subtest: pipe-A-eDP-1
[1023.478287] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[1023.490021] Starting dynamic subtest: pipe-B-eDP-1
[1024.618865] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[1024.623982] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.241s)
[1025.917181] [142/154] ( 11s left) kms_plane (pixel-format-y-tiled-modifier)
[1025.983027] Starting subtest: pixel-format-y-tiled-modifier
[1025.988156] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[1026.060151] [143/154] ( 11s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[1026.148405] Starting subtest: y-tiled-64bpp-rotate-90
[1026.153452] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[1026.248419] [144/154] ( 11s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[1026.332866] Starting subtest: yf-tiled-8bpp-rotate-270
[1026.338084] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[1026.433834] [145/154] ( 11s left) gem_ctx_param (invalid-get-engines)
[1026.482620] Starting subtest: invalid-get-engines
[1026.485503] Subtest invalid-get-engines: SUCCESS (0.001s)
[1026.600708] [146/154] ( 11s left) i915_hangman (engine-engine-error)
[1026.663128] Starting subtest: engine-engine-error
[1026.665884] Starting dynamic subtest: rcs0
[1028.036832] Dynamic subtest rcs0: SUCCESS (1.372s)
[1028.048640] Starting dynamic subtest: bcs0
[1030.020431] Dynamic subtest bcs0: SUCCESS (1.981s)
[1030.033864] Starting dynamic subtest: vcs0
[1032.067917] Dynamic subtest vcs0: SUCCESS (2.045s)
[1032.080749] Starting dynamic subtest: vcs1
[1034.054835] Dynamic subtest vcs1: SUCCESS (1.984s)
[1034.067160] Starting dynamic subtest: vecs0
[1036.036154] Dynamic subtest vecs0: SUCCESS (1.980s)
[1036.049967] Starting dynamic subtest: ccs0
[1038.084287] Dynamic subtest ccs0: SUCCESS (2.045s)
[1038.087293] Subtest engine-engine-error: SUCCESS (11.422s)
[1038.148318] Overall timeout time exceeded, stopping.
[1038.164144] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_pipe_stress
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: gen9_exec_parse
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: kms_chamelium_edid
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: sriov_basic
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_chamelium_color
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_render_tiled_blits
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: syncobj_basic
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_color_pipeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_setmode
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: api_intel_allocator
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_legacy_colorkey
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_fence
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_psr2_sf
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_readwrite
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: prime_mmap
results: parsing output: 83/ for test: kms_pipe_b_c_ivb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_partial_pwrite_pread
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_getfb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_fenced_exec_thrash
results: parsing output: 97/ for test: kms_plane_multiple
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: gem_madvise
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_capture
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: fbdev
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: dumb_buffer
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_selftest
results: parsing output: 124/ for test: kms_dsc
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_invalid_mode
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: gem_render_copy
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: gem_exec_reloc
results: parsing output: 135/ for test: gem_softpin
results: parsing output: 136/ for test: kms_chamelium_hpd
results: parsing output: 137/ for test: gem_userptr_blits
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gem_eio
results: parsing output: 140/ for test: kms_psr2_sf
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: gem_ctx_param
results: parsing output: 145/ for test: i915_hangman
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 148/ for test: gem_readwrite
results: no output, setting notrun
results: parsing output: 149/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 150/ for test: perf_pmu
results: no output, setting notrun
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 152/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 153/ for test: kms_prop_blob
results: no output, setting notrun
Done.