[57.842437] Initializing watchdogs
[57.842495]   /dev/watchdog0
[57.857720] [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]
[57.862254] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.864637] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.868216] [001/155] (960s left) gem_exec_schedule (preempt-hang)
[58.060101] Starting subtest: preempt-hang
[58.063520] Starting dynamic subtest: rcs0
[58.305539] Dynamic subtest rcs0: SUCCESS (0.246s)
[58.315038] Starting dynamic subtest: bcs0
[58.546643] Dynamic subtest bcs0: SUCCESS (0.240s)
[58.556988] Starting dynamic subtest: vcs0
[58.767085] Dynamic subtest vcs0: SUCCESS (0.224s)
[58.774853] Starting dynamic subtest: vcs1
[58.989198] Dynamic subtest vcs1: SUCCESS (0.219s)
[58.999670] Starting dynamic subtest: vecs0
[59.209731] Dynamic subtest vecs0: SUCCESS (0.222s)
[59.217533] Starting dynamic subtest: ccs0
[59.454919] Dynamic subtest ccs0: SUCCESS (0.245s)
[59.456944] Subtest preempt-hang: SUCCESS (1.399s)
[60.423795] [002/155] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[60.537135] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[60.541431] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[60.629583] [003/155] (957s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[60.678795] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[60.681117] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[60.782610] [004/155] (957s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[60.879707] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[60.881996] Starting dynamic subtest: pipe-A-eDP-1
[60.939316] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[60.946324] Starting dynamic subtest: pipe-B-eDP-1
[61.007790] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[61.015221] Starting dynamic subtest: pipe-C-eDP-1
[61.072269] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[61.081304] Starting dynamic subtest: pipe-D-eDP-1
[61.139272] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[61.143732] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[63.238418] [005/155] (955s left) gem_exec_schedule (u-lateslice)
[63.312629] Starting subtest: u-lateslice
[63.314640] Starting dynamic subtest: rcs0
[63.323165] Dynamic subtest rcs0: SUCCESS (0.021s)
[63.332917] Starting dynamic subtest: bcs0
[63.339964] Dynamic subtest bcs0: SUCCESS (0.016s)
[63.347941] Starting dynamic subtest: vcs0
[63.359370] Dynamic subtest vcs0: SUCCESS (0.020s)
[63.366862] Starting dynamic subtest: vcs1
[63.377173] Dynamic subtest vcs1: SUCCESS (0.018s)
[63.384658] Starting dynamic subtest: vecs0
[63.394417] Dynamic subtest vecs0: SUCCESS (0.017s)
[63.402008] Starting dynamic subtest: ccs0
[63.409506] Dynamic subtest ccs0: SUCCESS (0.015s)
[63.411667] Subtest u-lateslice: SUCCESS (0.109s)
[65.388346] [006/155] (953s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[65.494642] Starting subtest: yf-tiled-64bpp-rotate-0
[65.498886] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[65.608801] [007/155] (952s left) kms_vblank (query-idle-hang)
[65.703882] Starting subtest: query-idle-hang
[65.706243] Starting dynamic subtest: pipe-A-eDP-1
[92.129680] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.434s)
[92.144234] Starting dynamic subtest: pipe-D-eDP-1
[107.117892] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.985s)
[107.119841] Subtest query-idle-hang: SUCCESS (41.423s)
[107.989621] [008/155] (910s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[108.091055] Starting subtest: psr-rgb565-draw-mmap-wc
[115.022102] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.938s)
[115.126768] [009/155] (903s left) gem_exec_balancer (nohangcheck)
[115.393284] Starting subtest: nohangcheck
[116.336887] Subtest nohangcheck: SUCCESS (0.944s)
[116.450492] [010/155] (902s left) syncobj_basic (bad-create-flags)
[116.494729] Starting subtest: bad-create-flags
[116.496604] Subtest bad-create-flags: SUCCESS (0.000s)
[116.604341] [011/155] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[116.711864] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[124.188076] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.484s)
[124.322597] [012/155] (894s left) prime_busy (before-wait)
[124.386972] Starting subtest: before-wait
[124.391600] Starting dynamic subtest: rcs0
[124.427368] Dynamic subtest rcs0: SUCCESS (0.037s)
[124.436337] Starting dynamic subtest: bcs0
[124.467201] Dynamic subtest bcs0: SUCCESS (0.040s)
[124.475208] Starting dynamic subtest: vcs0
[124.507637] Dynamic subtest vcs0: SUCCESS (0.040s)
[124.515631] Starting dynamic subtest: vcs1
[124.549956] Dynamic subtest vcs1: SUCCESS (0.042s)
[124.557871] Starting dynamic subtest: vecs0
[124.592361] Dynamic subtest vecs0: SUCCESS (0.042s)
[124.600418] Starting dynamic subtest: ccs0
[124.633903] Dynamic subtest ccs0: SUCCESS (0.041s)
[124.742591] Subtest before-wait: SUCCESS (0.354s)
[124.827071] [013/155] (894s left) gem_userptr_blits (mmap-offset-banned)
[124.897756] Starting subtest: mmap-offset-banned
[124.899820] Starting dynamic subtest: wb
[124.901860] Dynamic subtest wb: SUCCESS (0.000s)
[124.911804] Starting dynamic subtest: wc
[124.913967] Dynamic subtest wc: SUCCESS (0.000s)
[124.921818] Starting dynamic subtest: uc
[124.924041] Dynamic subtest uc: SUCCESS (0.000s)
[124.926250] Subtest mmap-offset-banned: SUCCESS (0.002s)
[125.024108] [014/155] (893s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[125.300563] Starting subtest: cursor-rapid-movement-512x170
[125.305214] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[125.450928] [015/155] (893s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt)
[125.546268] Starting subtest: hdr-rgb565-draw-mmap-gtt
[125.550647] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[125.634416] [016/155] (893s left) kms_feature_discovery (display-4x)
[125.735599] Starting subtest: display-4x
[125.740099] Subtest display-4x: SKIP (0.000s)
[125.818953] [017/155] (893s left) gem_mmap_offset (mmap-unmap)
[125.873052] Starting subtest: mmap-unmap
[125.874838] Starting dynamic subtest: smem0
[150.957171] Dynamic subtest smem0: SUCCESS (25.083s)
[150.960227] Subtest mmap-unmap: SUCCESS (25.084s)
[151.088954] [018/155] (867s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[151.185657] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[151.190037] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[151.282081] [019/155] (867s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[151.385261] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[151.387895] Starting dynamic subtest: pipe-A-eDP-1
[151.411650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.421707] Starting dynamic subtest: pipe-B-eDP-1
[151.443148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.451444] Starting dynamic subtest: pipe-C-eDP-1
[151.473364] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.481679] Starting dynamic subtest: pipe-D-eDP-1
[151.504438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.508588] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[153.629719] [020/155] (865s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[153.734443] Starting subtest: psrhdr-rgb101010-draw-pwrite
[153.738824] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[153.861169] [021/155] (865s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[153.967422] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[154.635536] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[154.795177] [022/155] (864s left) kms_flip (dpms-off-confusion)
[154.886174] Starting subtest: dpms-off-confusion
[154.888450] Starting dynamic subtest: A-eDP1
[163.545060] Dynamic subtest A-eDP1: SUCCESS (8.657s)
[163.554252] Starting dynamic subtest: B-eDP1
[172.289074] Dynamic subtest B-eDP1: SUCCESS (8.743s)
[172.300105] Starting dynamic subtest: C-eDP1
[181.019014] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[181.028394] Starting dynamic subtest: D-eDP1
[189.652857] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[189.655263] Subtest dpms-off-confusion: SUCCESS (34.768s)
[190.834139] [023/155] (828s left) kms_lease (lease-unleased-crtc)
[190.927962] Starting subtest: lease-unleased-crtc
[190.930406] Starting dynamic subtest: pipe-A-eDP-1
[191.216660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[191.224837] Starting dynamic subtest: pipe-B-eDP-1
[191.971725] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[191.983409] Starting dynamic subtest: pipe-C-eDP-1
[191.985626] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[191.993412] Starting dynamic subtest: pipe-D-eDP-1
[191.995639] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[191.997846] Subtest lease-unleased-crtc: SUCCESS (1.055s)
[192.365121] [024/155] (826s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[192.465345] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[192.467630] Starting dynamic subtest: pipe-A-eDP-1
[192.490616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.500691] Starting dynamic subtest: pipe-B-eDP-1
[192.522298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.530406] Starting dynamic subtest: pipe-C-eDP-1
[192.553074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.560996] Starting dynamic subtest: pipe-D-eDP-1
[192.584306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.588594] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[194.739776] [025/155] (824s left) kms_psr (pr-sprite-mmap-gtt)
[194.841296] Starting subtest: pr-sprite-mmap-gtt
[194.845601] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[194.912220] [026/155] (824s left) gem_mmap_gtt (medium-copy-odd)
[194.964976] Subtest medium-copy-odd: SKIP (0.000s)
[195.021770] [027/155] (824s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[195.118853] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[195.123657] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[195.192307] [028/155] (824s left) gem_flink_basic (bad-flink)
[195.242983] Starting subtest: bad-flink
[195.245416] Subtest bad-flink: SUCCESS (0.000s)
[195.357230] [029/155] (824s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[195.450569] Starting subtest: fbchdr-rgb565-draw-pwrite
[195.454775] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[195.533902] [030/155] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[195.639185] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[195.643568] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.729843] [031/155] (823s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[196.107350] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[196.949545] [032/155] (822s left) gem_exec_whisper (basic-queues-priority)
[197.008689] Starting subtest: basic-queues-priority
[221.253909] Subtest basic-queues-priority: SUCCESS (24.241s)
[221.450404] [033/155] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[221.567931] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[221.572570] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[221.675238] [034/155] (798s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[221.779602] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[221.783634] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[221.854888] [035/155] (797s left) kms_psr (fbc-psr-primary-page-flip)
[221.953033] Starting subtest: fbc-psr-primary-page-flip
[221.955211] Starting dynamic subtest: eDP-1
[221.959166] Dynamic subtest eDP-1: SKIP (0.000s)
[221.963184] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[222.027262] [036/155] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[222.135992] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[229.632568] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.502s)
[229.765219] [037/155] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[229.869554] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[233.513951] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.651s)
[234.735448] [038/155] (785s left) kms_psr (fbc-psr2-primary-blt)
[234.830971] Starting subtest: fbc-psr2-primary-blt
[234.833331] Starting dynamic subtest: eDP-1
[234.837526] Dynamic subtest eDP-1: SKIP (0.000s)
[234.841800] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[234.910769] [039/155] (784s left) sysfs_heartbeat_interval (invalid)
[234.966475] Starting subtest: invalid
[234.968837] Starting dynamic subtest: vecs0
[234.971223] Dynamic subtest vecs0: SUCCESS (0.000s)
[234.981725] Starting dynamic subtest: ccs0
[234.983636] Dynamic subtest ccs0: SUCCESS (0.000s)
[234.991941] Starting dynamic subtest: vcs0
[234.993850] Dynamic subtest vcs0: SUCCESS (0.000s)
[235.002626] Starting dynamic subtest: bcs0
[235.004580] Dynamic subtest bcs0: SUCCESS (0.000s)
[235.013071] Starting dynamic subtest: rcs0
[235.014951] Dynamic subtest rcs0: SUCCESS (0.000s)
[235.023165] Starting dynamic subtest: vcs1
[235.025039] Dynamic subtest vcs1: SUCCESS (0.000s)
[235.026944] Subtest invalid: SUCCESS (0.004s)
[235.084868] [040/155] (784s left) kms_flip (2x-flip-vs-modeset)
[235.180572] Starting subtest: 2x-flip-vs-modeset
[235.192757] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[235.268293] [041/155] (784s left) gem_exec_async (concurrent-writes)
[235.333679] Starting subtest: concurrent-writes
[235.336096] Starting dynamic subtest: rcs0
[235.351392] Dynamic subtest rcs0: SUCCESS (0.017s)
[235.363386] Starting dynamic subtest: bcs0
[235.365713] Dynamic subtest bcs0: SUCCESS (0.006s)
[235.374629] Starting dynamic subtest: vcs0
[235.376542] Dynamic subtest vcs0: SUCCESS (0.006s)
[235.386346] Starting dynamic subtest: vcs1
[235.388588] Dynamic subtest vcs1: SUCCESS (0.007s)
[235.397164] Starting dynamic subtest: vecs0
[235.399053] Dynamic subtest vecs0: SUCCESS (0.006s)
[235.407252] Starting dynamic subtest: ccs0
[235.409124] Dynamic subtest ccs0: SUCCESS (0.007s)
[235.410996] Subtest concurrent-writes: SUCCESS (0.052s)
[235.615434] [042/155] (784s left) kms_psr (psr2-primary-mmap-gtt)
[235.714243] Starting subtest: psr2-primary-mmap-gtt
[235.716141] Starting dynamic subtest: eDP-1
[237.108991] Dynamic subtest eDP-1: SKIP (1.391s)
[237.113795] Subtest psr2-primary-mmap-gtt: SKIP (1.393s)
[237.249514] [043/155] (782s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[237.354414] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[237.358921] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[237.454034] [044/155] (782s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[237.560171] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[237.564602] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[237.652922] [045/155] (782s left) gem_exec_gttfill (all-engines)
[237.715539] Starting subtest: all-engines
[260.774327] Subtest all-engines: SUCCESS (23.058s)
[260.958029] [046/155] (759s left) i915_pm_freq_api (freq-reset)
[261.057728] Starting subtest: freq-reset
[261.060182] Starting dynamic subtest: gt0
[261.258153] Dynamic subtest gt0: SUCCESS (0.199s)
[261.268493] Starting dynamic subtest: gt1
[261.428756] Dynamic subtest gt1: SUCCESS (0.166s)
[261.431417] Subtest freq-reset: SUCCESS (0.366s)
[261.507657] [047/155] (758s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[261.618777] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[261.623044] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[261.689174] [048/155] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[261.790880] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[266.222671] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.436s)
[267.362010] [049/155] (752s left) gem_ctx_param (basic)
[267.418503] Starting subtest: basic
[267.421067] Subtest basic: SUCCESS (0.001s)
[267.515533] [050/155] (752s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[267.613894] Starting subtest: x-tiled-addfb-size-offset-overflow
[267.616247] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[267.728170] [051/155] (752s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[267.782602] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[267.787178] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[267.964543] [052/155] (752s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[268.068405] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[274.969962] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.906s)
[275.082122] [053/155] (745s left) kms_color (invalid-degamma-lut-sizes)
[275.175069] Starting subtest: invalid-degamma-lut-sizes
[275.177357] Starting dynamic subtest: pipe-A
[276.234354] Dynamic subtest pipe-A: SUCCESS (1.060s)
[276.245261] Starting dynamic subtest: pipe-B
[276.247632] Dynamic subtest pipe-B: SUCCESS (0.000s)
[276.257085] Starting dynamic subtest: pipe-C
[276.259418] Dynamic subtest pipe-C: SUCCESS (0.000s)
[276.268723] Starting dynamic subtest: pipe-D
[276.270657] Dynamic subtest pipe-D: SUCCESS (0.000s)
[276.272647] Subtest invalid-degamma-lut-sizes: SUCCESS (1.064s)
[276.575720] [054/155] (743s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[276.674063] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[276.676798] Starting dynamic subtest: pipe-A-eDP-1
[276.702191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[276.713797] Starting dynamic subtest: pipe-B-eDP-1
[276.732585] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[276.742057] Starting dynamic subtest: pipe-C-eDP-1
[276.761374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[276.770439] Starting dynamic subtest: pipe-D-eDP-1
[276.790149] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[276.792373] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[278.941606] [055/155] (741s left) gem_ctx_bad_destroy (invalid-ctx)
[279.003792] Starting subtest: invalid-ctx
[279.006161] Subtest invalid-ctx: SUCCESS (0.000s)
[279.087376] [056/155] (741s left) kms_cursor_crc (cursor-offscreen-32x32)
[279.229679] Starting subtest: cursor-offscreen-32x32
[279.277845] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[279.567623] [057/155] (741s left) perf (whitelisted-registers-userspace-config)
[279.726717] Starting subtest: whitelisted-registers-userspace-config
[279.728910] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[279.766358] [058/155] (740s left) kms_flip (nonexisting-fb-interruptible)
[279.858803] Starting subtest: nonexisting-fb-interruptible
[279.860868] Starting dynamic subtest: A-eDP1
[281.033849] Dynamic subtest A-eDP1: SUCCESS (1.173s)
[281.043984] Starting dynamic subtest: B-eDP1
[282.159495] Dynamic subtest B-eDP1: SUCCESS (1.125s)
[282.171612] Starting dynamic subtest: C-eDP1
[283.290667] Dynamic subtest C-eDP1: SUCCESS (1.130s)
[283.302138] Starting dynamic subtest: D-eDP1
[284.432430] Dynamic subtest D-eDP1: SUCCESS (1.140s)
[284.437594] Subtest nonexisting-fb-interruptible: SUCCESS (4.578s)
[285.639185] [059/155] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[285.747201] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[285.751223] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[285.838605] [060/155] (734s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[285.933622] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[285.938072] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[286.041763] [061/155] (734s left) gem_ctx_exec (basic-invalid-context)
[286.104387] Starting subtest: basic-invalid-context
[286.106583] Subtest basic-invalid-context: SUCCESS (0.005s)
[286.231198] [062/155] (734s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[286.290742] Subtest tiled-to-tiled: SKIP (0.000s)
[286.360440] [063/155] (734s left) kms_pm_rpm (fences-dpms)
[288.502656] Starting subtest: fences-dpms
[288.507460] Subtest fences-dpms: SKIP (0.000s)
[288.893336] [064/155] (731s left) fbdev (write)
[288.932961] Starting subtest: write
[289.297284] Subtest write: SUCCESS (0.362s)
[289.369493] [065/155] (731s left) gem_pxp (reject-modify-context-protection-on)
[289.490859] Starting subtest: reject-modify-context-protection-on
[289.494323] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[289.617917] [066/155] (731s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[289.744078] Starting subtest: cursorA-vs-flipA-legacy
[300.871878] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.125s)
[301.721294] [067/155] (719s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[301.776694] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[301.778979] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[301.880635] [068/155] (719s left) i915_pm_rps (thresholds)
[301.948990] Starting subtest: thresholds
[301.953435] Subtest thresholds: SKIP (0.001s)
[302.045889] [069/155] (719s left) gem_mmap (basic)
[302.096305] Subtest basic: SKIP (0.000s)
[302.159310] [070/155] (718s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[302.266427] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[306.362341] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.100s)
[307.538398] [071/155] (713s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[307.633390] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[307.646092] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[307.719528] [072/155] (713s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[307.816677] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[307.820929] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.914507] [073/155] (713s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[308.015050] Starting subtest: fbcpsrhdr-tiling-linear
[308.019599] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[308.107370] [074/155] (713s left) syncobj_timeline (device-submit-unordered)
[308.159090] Starting subtest: device-submit-unordered
[308.161123] Subtest device-submit-unordered: SUCCESS (0.001s)
[308.251215] [075/155] (713s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[308.344196] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[308.348490] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[308.438734] [076/155] (712s left) kms_chamelium_audio (dp-audio)
[308.833644] Subtest dp-audio: SKIP (0.000s)
[309.643792] [077/155] (711s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[309.730284] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[309.734498] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[309.795944] [078/155] (711s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[309.887627] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[310.954489] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.067s)
[311.079220] [079/155] (710s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[311.196425] Starting subtest: 2x-flip-vs-cursor-atomic
[311.200164] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[311.352661] [080/155] (710s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[311.454769] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[311.458298] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.555096] [081/155] (709s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[311.944318] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[312.781886] [082/155] (708s left) vgem_basic (dmabuf-fence)
[312.905357] Starting subtest: dmabuf-fence
[312.907318] Subtest dmabuf-fence: SUCCESS (0.000s)
[312.975868] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[312.980338] [083/155] (708s left) gem_exec_fence (basic-await)
[313.156624] Starting subtest: basic-await
[313.159342] Starting dynamic subtest: rcs0
[313.233397] Dynamic subtest rcs0: SUCCESS (0.076s)
[313.246898] Starting dynamic subtest: bcs0
[313.305841] Dynamic subtest bcs0: SUCCESS (0.071s)
[313.320705] Starting dynamic subtest: vcs0
[313.381207] Dynamic subtest vcs0: SUCCESS (0.073s)
[313.393949] Starting dynamic subtest: vcs1
[313.454280] Dynamic subtest vcs1: SUCCESS (0.071s)
[313.466690] Starting dynamic subtest: vecs0
[313.528587] Dynamic subtest vecs0: SUCCESS (0.072s)
[313.539499] Starting dynamic subtest: ccs0
[313.602554] Dynamic subtest ccs0: SUCCESS (0.071s)
[313.605023] Subtest basic-await: SUCCESS (0.447s)
[315.384123] [084/155] (706s left) gem_mmap_wc (write-prefaulted)
[315.436860] Subtest write-prefaulted: SKIP (0.000s)
[315.515551] [085/155] (706s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[315.616574] Starting subtest: fbc-farfromfence-mmap-gtt
[315.620887] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[315.697941] [086/155] (706s left) gen7_exec_parse (load-register-reg)
[315.756429] Subtest load-register-reg: SKIP (0.000s)
[315.830096] [087/155] (705s left) kms_psr (fbc-pr-primary-mmap-cpu)
[315.930846] Starting subtest: fbc-pr-primary-mmap-cpu
[315.935116] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[316.038895] [088/155] (705s left) gem_tiling_max_stride
[316.161903] [089/155] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[316.272233] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[317.319597] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.048s)
[317.429686] [090/155] (704s left) gem_exec_await (wide-contexts)
[317.618484] Starting subtest: wide-contexts
[341.021914] Subtest wide-contexts: SUCCESS (23.403s)
[341.228883] [091/155] (680s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[341.380737] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[341.385163] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[341.478116] [092/155] (680s left) gem_exec_fence (submit)
[341.656625] Starting subtest: submit
[341.661048] Subtest submit: SKIP (0.000s)
[343.411265] [093/155] (678s left) gem_render_tiled_blits (basic)
[343.468450] Subtest basic: SKIP (0.000s)
[343.540763] [094/155] (678s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[343.630611] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[343.635055] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[343.728307] [095/155] (678s left) gem_exec_store (cachelines)
[343.793069] Starting subtest: cachelines
[343.795299] Starting dynamic subtest: rcs0
[343.879784] Dynamic subtest rcs0: SUCCESS (0.088s)
[343.893912] Starting dynamic subtest: bcs0
[343.934578] Dynamic subtest bcs0: SUCCESS (0.053s)
[343.946431] Starting dynamic subtest: vcs0
[343.997545] Dynamic subtest vcs0: SUCCESS (0.061s)
[344.009281] Starting dynamic subtest: vcs1
[344.056663] Dynamic subtest vcs1: SUCCESS (0.057s)
[344.068602] Starting dynamic subtest: vecs0
[344.112392] Dynamic subtest vecs0: SUCCESS (0.054s)
[344.123961] Starting dynamic subtest: ccs0
[344.172626] Dynamic subtest ccs0: SUCCESS (0.059s)
[344.174983] Subtest cachelines: SUCCESS (0.383s)
[344.363865] [096/155] (677s left) i915_drm_fdinfo (memory-info-resident)
[344.405902] Starting subtest: memory-info-resident
[344.408178] Starting dynamic subtest: smem0
[347.089092] Dynamic subtest smem0: SUCCESS (2.683s)
[347.091267] Subtest memory-info-resident: SUCCESS (2.684s)
[347.163061] [097/155] (675s left) kms_plane_alpha_blend (alpha-7efc)
[347.254861] Starting subtest: alpha-7efc
[347.548286] Starting dynamic subtest: pipe-A-eDP-1
[348.136872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[348.166076] Starting dynamic subtest: pipe-D-eDP-1
[349.504799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[349.507085] Subtest alpha-7efc: SUCCESS (2.252s)
[350.357855] [098/155] (671s left) gem_mmap_gtt (close-race)
[350.411158] Subtest close-race: SKIP (0.000s)
[350.466881] [099/155] (671s left) kms_joiner (invalid-modeset-big-joiner)
[350.553482] Starting subtest: invalid-modeset-big-joiner
[350.557312] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[350.624970] [100/155] (671s left) gem_ppgtt (blt-vs-render-ctxn)
[350.689185] Starting subtest: blt-vs-render-ctxN
[383.383726] Subtest blt-vs-render-ctxN: SUCCESS (32.690s)
[383.507266] [101/155] (638s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[383.645342] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[383.649565] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[383.734213] [102/155] (638s left) vgem_basic (setversion)
[383.779311] Starting subtest: setversion
[383.783603] Subtest setversion: SUCCESS (0.000s)
[383.834624] [103/155] (638s left) core_sysfs (read-all-entries)
[383.898513] Starting subtest: read-all-entries
[383.909850] Subtest read-all-entries: SUCCESS (0.013s)
[384.005896] [104/155] (638s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[384.061144] Starting subtest: invalid-single-wait-unsubmitted
[384.063457] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[384.166187] [105/155] (638s left) kms_plane (plane-panning-top-left)
[384.262342] Starting subtest: plane-panning-top-left
[384.264271] Starting dynamic subtest: pipe-A
[386.015535] Dynamic subtest pipe-A: SUCCESS (1.752s)
[386.027084] Starting dynamic subtest: pipe-B
[388.508921] Dynamic subtest pipe-B: SUCCESS (2.492s)
[388.511312] Subtest plane-panning-top-left: SUCCESS (4.247s)
[389.382968] [106/155] (633s left) gem_ctx_param (invalid-set-ringsize)
[389.442996] Starting subtest: invalid-set-ringsize
[389.445436] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[389.519103] [107/155] (633s left) kms_invalid_mode (bad-hsync-end)
[389.615204] Starting subtest: bad-hsync-end
[389.617389] Starting dynamic subtest: pipe-A-eDP-1
[389.901732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[389.913239] Starting dynamic subtest: pipe-B-eDP-1
[389.915369] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[389.925769] Starting dynamic subtest: pipe-C-eDP-1
[389.928192] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[389.940719] Starting dynamic subtest: pipe-D-eDP-1
[389.943126] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[389.945411] Subtest bad-hsync-end: SUCCESS (0.294s)
[390.713801] [108/155] (631s left) api_intel_bb (reset-flags)
[390.773804] Starting subtest: reset-flags
[390.778068] Subtest reset-flags: SUCCESS (0.007s)
[390.906452] [109/155] (631s left) perf_pmu (busy-no-semaphores)
[390.948090] Starting subtest: busy-no-semaphores
[390.950923] Starting dynamic subtest: rcs0
[391.519819] Dynamic subtest rcs0: SUCCESS (0.568s)
[391.540912] Starting dynamic subtest: bcs0
[392.072767] Dynamic subtest bcs0: SUCCESS (0.550s)
[392.084107] Starting dynamic subtest: vcs0
[392.619525] Dynamic subtest vcs0: SUCCESS (0.546s)
[392.631466] Starting dynamic subtest: vcs1
[393.833317] Dynamic subtest vcs1: SUCCESS (1.209s)
[393.844934] Starting dynamic subtest: vecs0
[395.880487] Dynamic subtest vecs0: SUCCESS (2.044s)
[395.894127] Starting dynamic subtest: ccs0
[397.864077] Dynamic subtest ccs0: SUCCESS (1.980s)
[397.866660] Subtest busy-no-semaphores: SUCCESS (6.916s)
[397.989733] [110/155] (624s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[398.092394] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[398.096577] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.208312] [111/155] (624s left) perf_pmu (event-wait)
[398.248288] Starting subtest: event-wait
[398.250673] Starting dynamic subtest: rcs0
[398.255215] Dynamic subtest rcs0: SKIP (0.000s)
[398.259693] Subtest event-wait: SKIP (0.001s)
[398.357393] [112/155] (624s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[398.451967] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[398.456467] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.551125] [113/155] (624s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[398.640590] Starting subtest: primary-4-tiled-reflect-x-180
[405.626196] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.987s)
[406.795412] [114/155] (616s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[406.903491] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[406.907858] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[407.004800] [115/155] (616s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[407.106784] Starting subtest: fbc-modesetfrombusy
[410.868783] Subtest fbc-modesetfrombusy: SUCCESS (3.769s)
[412.049505] [116/155] (610s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[412.149437] Starting subtest: 2x-plain-flip-ts-check-interruptible
[412.161657] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[412.241225] [117/155] (610s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[412.337658] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[412.341758] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[412.450261] [118/155] (610s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[412.567605] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[412.571792] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[412.643352] [119/155] (610s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[412.735077] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[412.739080] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[412.805576] [120/155] (610s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[412.901618] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[412.905660] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[413.004080] [121/155] (610s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[413.098376] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[413.101868] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[413.206352] [122/155] (610s left) syncobj_basic (illegal-fd-to-handle)
[413.271392] Starting subtest: illegal-fd-to-handle
[413.273266] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[413.369397] [123/155] (609s left) kms_flip (modeset-vs-vblank-race-interruptible)
[413.460361] Starting subtest: modeset-vs-vblank-race-interruptible
[413.462179] Starting dynamic subtest: A-eDP1
[418.263479] Dynamic subtest A-eDP1: SUCCESS (4.802s)
[418.279497] Starting dynamic subtest: B-eDP1
[423.019967] Dynamic subtest B-eDP1: SUCCESS (4.753s)
[423.033673] Starting dynamic subtest: C-eDP1
[427.723159] Dynamic subtest C-eDP1: SUCCESS (4.701s)
[427.735812] Starting dynamic subtest: D-eDP1
[432.381839] Dynamic subtest D-eDP1: SUCCESS (4.657s)
[432.387311] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.928s)
[433.553461] [124/155] (589s left) prime_mmap (test_userptr)
[433.618738] Starting subtest: test_userptr
[433.621163] Starting dynamic subtest: test_userptr-smem
[433.623494] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[433.625506] Subtest test_userptr: SUCCESS (0.002s)
[433.738701] [125/155] (589s left) syncobj_timeline (single-wait-for-submit-signaled)
[433.790835] Starting subtest: single-wait-for-submit-signaled
[433.792670] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[433.886173] [126/155] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[433.982414] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[433.986734] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[434.085285] [127/155] (589s left) gem_spin_batch (resubmit-new)
[434.148032] Starting subtest: resubmit-new
[434.150320] Starting dynamic subtest: rcs0
[434.156103] Dynamic subtest rcs0: SUCCESS (0.008s)
[434.166536] Starting dynamic subtest: bcs0
[434.168779] Dynamic subtest bcs0: SUCCESS (0.006s)
[434.178793] Starting dynamic subtest: vcs0
[434.180701] Dynamic subtest vcs0: SUCCESS (0.007s)
[434.190580] Starting dynamic subtest: vcs1
[434.192711] Dynamic subtest vcs1: SUCCESS (0.004s)
[434.202587] Starting dynamic subtest: vecs0
[434.204779] Dynamic subtest vecs0: SUCCESS (0.005s)
[434.214880] Starting dynamic subtest: ccs0
[434.217094] Dynamic subtest ccs0: SUCCESS (0.004s)
[434.219293] Subtest resubmit-new: SUCCESS (0.037s)
[435.404956] [128/155] (588s left) kms_selftest (drm_format_helper)
[435.453585] Starting subtest: drm_format_helper
[435.519534] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[435.610653] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.092s)
[435.628787] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[435.700538] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.088s)
[435.712863] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[435.800456] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.100s)
[435.810587] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[435.888116] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.086s)
[435.899744] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[436.007243] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.118s)
[436.017614] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[436.099536] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.092s)
[436.111594] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[436.198393] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.098s)
[436.210455] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[436.292397] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.093s)
[436.302411] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[436.392057] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.097s)
[436.402028] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[436.485670] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.094s)
[436.495737] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[436.586357] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.099s)
[436.596682] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[436.685085] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.099s)
[436.697909] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[436.786988] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.097s)
[436.797757] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[436.875479] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.091s)
[436.885594] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[436.978572] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.101s)
[436.991503] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[437.067715] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.090s)
[437.077276] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[437.177775] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.107s)
[437.179367] Subtest drm_format_helper: SUCCESS (1.724s)
[437.327713] [129/155] (586s left) kms_addfb_basic (bad-pitch-63)
[437.380874] Starting subtest: bad-pitch-63
[437.382452] Subtest bad-pitch-63: SUCCESS (0.000s)
[437.529831] [130/155] (586s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[437.579968] Starting subtest: legacy-engines-hostile-preempt
[437.581872] Starting dynamic subtest: render
[437.663278] Dynamic subtest render: SUCCESS (0.083s)
[437.679362] Starting dynamic subtest: bsd1
[439.327516] Dynamic subtest bsd1: SUCCESS (1.659s)
[439.339984] Starting dynamic subtest: bsd2
[441.292080] Dynamic subtest bsd2: SUCCESS (1.961s)
[441.304747] Starting dynamic subtest: blt
[441.351067] Dynamic subtest blt: SUCCESS (0.059s)
[441.361482] Starting dynamic subtest: vebox
[443.344262] Dynamic subtest vebox: SUCCESS (1.990s)
[443.346772] Subtest legacy-engines-hostile-preempt: SUCCESS (5.764s)
[443.467409] [131/155] (580s left) kms_atomic (plane-primary-legacy)
[443.565895] Starting subtest: plane-primary-legacy
[443.568249] Starting dynamic subtest: pipe-A-eDP-1
[443.990951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[443.993217] Subtest plane-primary-legacy: SUCCESS (0.425s)
[444.890960] [132/155] (578s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-blt)
[444.994775] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-blt
[444.998777] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[445.087282] [133/155] (578s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[445.195226] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[445.199081] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.292997] [134/155] (578s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[445.392016] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[445.396289] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[445.483867] [135/155] (578s left) kms_cursor_edge_walk (64x64-right-edge)
[445.575771] Starting subtest: 64x64-right-edge
[445.578077] Starting dynamic subtest: pipe-A-eDP-1
[449.054784] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[449.065686] Starting dynamic subtest: pipe-D-eDP-1
[452.262167] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.207s)
[452.264335] Subtest 64x64-right-edge: SUCCESS (6.688s)
[453.076499] [136/155] (570s left) gem_exec_reloc (basic-write-wc-noreloc)
[453.133187] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[453.206996] [137/155] (570s left) kms_busy (extended-modeset-hang-oldfb)
[453.309030] Starting subtest: extended-modeset-hang-oldfb
[453.311335] Starting dynamic subtest: pipe-A
[465.259892] Dynamic subtest pipe-A: SUCCESS (11.948s)
[465.273963] Starting dynamic subtest: pipe-D
[477.539954] Dynamic subtest pipe-D: SUCCESS (12.277s)
[477.542404] Subtest extended-modeset-hang-oldfb: SUCCESS (24.230s)
[478.420144] [138/155] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[478.518578] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[485.880446] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.365s)
[486.009571] [139/155] (538s left) kms_plane_scaling (planes-upscale-factor-0-25)
[486.100210] Starting subtest: planes-upscale-factor-0-25
[486.102474] Starting dynamic subtest: pipe-A
[486.160819] Dynamic subtest pipe-A: SUCCESS (0.062s)
[486.173101] Starting dynamic subtest: pipe-B
[487.281909] Dynamic subtest pipe-B: SUCCESS (1.120s)
[487.293885] Starting dynamic subtest: pipe-C
[488.399731] Dynamic subtest pipe-C: SUCCESS (1.116s)
[488.411358] Starting dynamic subtest: pipe-D
[489.553290] Dynamic subtest pipe-D: SUCCESS (1.153s)
[489.555556] Subtest planes-upscale-factor-0-25: SUCCESS (3.456s)
[490.709154] [140/155] (533s left) i915_suspend (debugfs-reader)
[490.765671] Starting subtest: debugfs-reader
[509.054143] Subtest debugfs-reader: SUCCESS (4.403s)
[515.183700] [141/155] (515s left) kms_async_flips (async-flip-suspend-resume)
[515.304956] Starting subtest: async-flip-suspend-resume
[515.687844] Starting dynamic subtest: pipe-A-eDP-1
[534.048370] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.373s)
[534.431075] Starting dynamic subtest: pipe-B-eDP-1
[553.061974] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.311s)
[553.433030] Starting dynamic subtest: pipe-C-eDP-1
[572.061608] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.307s)
[572.430256] Starting dynamic subtest: pipe-D-eDP-1
[591.060667] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.305s)
[591.062467] Subtest async-flip-suspend-resume: SUCCESS (14.782s)
[597.281211] [142/155] (437s left) gem_exec_flush (basic-uc-set-default)
[597.349227] Starting subtest: basic-uc-set-default
[602.795915] Subtest basic-uc-set-default: SUCCESS (5.466s)
[602.987887] [143/155] (432s left) gem_readwrite (read-write)
[603.048107] Subtest read-write: SKIP (0.000s)
[603.118107] [144/155] (432s left) kms_plane (plane-panning-bottom-right)
[603.216816] Starting subtest: plane-panning-bottom-right
[603.218922] Starting dynamic subtest: pipe-A
[604.906746] Dynamic subtest pipe-A: SUCCESS (1.694s)
[604.918768] Starting dynamic subtest: pipe-B
[607.277401] Dynamic subtest pipe-B: SUCCESS (2.372s)
[607.279741] Subtest plane-panning-bottom-right: SUCCESS (4.069s)
[608.083290] [145/155] (427s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[608.199897] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[608.204437] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[608.344307] [146/155] (427s left) kms_content_protection (suspend-resume)
[608.498460] Starting subtest: suspend-resume
[608.503079] Subtest suspend-resume: SKIP (0.000s)
[608.639084] [147/155] (426s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[608.757289] Starting subtest: y-tiled-32bpp-rotate-180
[608.761668] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[608.868936] [148/155] (426s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[608.969524] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[608.973738] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[609.056638] [149/155] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[609.148702] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[609.152139] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[609.251498] [150/155] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[609.354650] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[609.357836] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[609.461990] [151/155] (426s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[609.549574] Starting subtest: primary-x-tiled-reflect-x-180
[616.572449] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.032s)
[617.735591] [152/155] (417s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[617.844116] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[617.848333] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[617.940282] [153/155] (417s left) i915_query (query-topology-unsupported)
[617.987378] Starting subtest: query-topology-unsupported
[617.991467] Subtest query-topology-unsupported: SKIP (0.000s)
[618.081183] [154/155] (417s left) api_intel_allocator (open-vm)
[618.130184] Starting subtest: open-vm
[618.132250] Subtest open-vm: SUCCESS (0.003s)
[618.243895] [155/155] (417s left) kms_prop_blob (invalid-get-prop-any)
[618.288176] Starting subtest: invalid-get-prop-any
[618.290237] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[618.377875] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: prime_busy
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_feature_discovery
results: parsing output: 16/ for test: gem_mmap_offset
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: gem_flink_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
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_psr
results: parsing output: 38/ for test: sysfs_heartbeat_interval
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: gem_exec_async
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_gttfill
results: parsing output: 45/ for test: i915_pm_freq_api
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_color
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_ctx_bad_destroy
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ctx_exec
results: parsing output: 61/ for test: gem_set_tiling_vs_blt
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: fbdev
results: parsing output: 64/ for test: gem_pxp
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: i915_pm_rps
results: parsing output: 68/ for test: gem_mmap
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_audio
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gen7_exec_parse
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_tiling_max_stride
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_await
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_render_tiled_blits
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_store
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: kms_plane_alpha_blend
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_joiner
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: core_sysfs
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_basic
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_spin_batch
results: parsing output: 127/ for test: kms_selftest
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_atomic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_cursor_edge_walk
results: parsing output: 135/ for test: gem_exec_reloc
results: parsing output: 136/ for test: kms_busy
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_plane_scaling
results: parsing output: 139/ for test: i915_suspend
results: parsing output: 140/ for test: kms_async_flips
results: parsing output: 141/ for test: gem_exec_flush
results: parsing output: 142/ for test: gem_readwrite
results: parsing output: 143/ for test: kms_plane
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: kms_content_protection
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_rotation_crc
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: i915_query
results: parsing output: 153/ for test: api_intel_allocator
results: parsing output: 154/ for test: kms_prop_blob
Done.