[59.123066] Initializing watchdogs
[59.123216]   /dev/watchdog0
[59.139898] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.144958] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.147493] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.150828] [001/156] (960s left) gem_ctx_persistence (userptr)
[59.234170] Starting subtest: userptr
[59.398971] Subtest userptr: SUCCESS (0.164s)
[59.487624] [002/156] (960s left) kms_cursor_crc (cursor-offscreen-512x170)
[59.777975] Starting subtest: cursor-offscreen-512x170
[59.782425] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[59.936276] [003/156] (959s left) perf (oa-formats)
[60.068465] Starting subtest: oa-formats
[60.070251] Starting dynamic subtest: 0-rcs0
[60.081931] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[60.090664] Starting dynamic subtest: 1-vcs0
[60.103899] Dynamic subtest 1-vcs0: SUCCESS (0.022s)
[60.105865] Subtest oa-formats: SUCCESS (0.037s)
[60.152189] [004/156] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[60.208912] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[60.269792] [005/156] (959s left) kms_content_protection (uevent-hdcp14)
[60.405265] Starting subtest: uevent-hdcp14
[60.409199] Subtest uevent-hdcp14: SKIP (0.000s)
[60.548054] [006/156] (959s left) sw_sync (sync_random_merge)
[60.583713] Starting subtest: sync_random_merge
[60.628329] Subtest sync_random_merge: SUCCESS (0.045s)
[60.699621] [007/156] (959s left) kms_big_fb (linear-16bpp-rotate-0)
[60.797626] Starting subtest: linear-16bpp-rotate-0
[62.142359] Subtest linear-16bpp-rotate-0: SUCCESS (1.345s)
[62.258863] [008/156] (957s left) gem_gtt_cpu_tlb
[62.376724] [009/156] (957s left) kms_vblank (query-forked-busy)
[62.470655] Starting subtest: query-forked-busy
[62.472688] Starting dynamic subtest: pipe-A-eDP-1
[64.359832] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[64.373033] Starting dynamic subtest: pipe-D-eDP-1
[66.983975] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[66.986308] Subtest query-forked-busy: SUCCESS (4.515s)
[67.876780] [010/156] (952s left) kms_debugfs (display-off-read-all)
[67.970278] Starting subtest: display-off-read-all
[68.262842] Subtest display-off-read-all: SUCCESS (0.295s)
[69.127962] [011/156] (950s left) gen7_exec_parse (basic-offset)
[69.193481] Subtest basic-offset: SKIP (0.000s)
[69.253161] [012/156] (950s left) gem_render_copy (x-tiled)
[69.313594] Starting subtest: x-tiled
[69.316217] Starting dynamic subtest: smem
[69.358680] Dynamic subtest smem: SUCCESS (0.045s)
[69.361420] Subtest x-tiled: SUCCESS (0.045s)
[69.535904] [013/156] (950s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[69.630146] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[69.634316] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[69.734382] [014/156] (950s left) syncobj_timeline (wait-all-interrupted)
[69.786035] Starting subtest: wait-all-interrupted
[69.887341] Subtest wait-all-interrupted: SUCCESS (0.101s)
[69.969104] [015/156] (950s left) prime_vgem (basic-fence-mmap)
[70.080901] Starting subtest: basic-fence-mmap
[70.085641] Subtest basic-fence-mmap: SKIP (0.000s)
[70.171608] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[70.175087] [016/156] (950s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[70.265578] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[70.270491] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.351339] [017/156] (949s left) sw_sync (sync_expired_merge)
[70.389549] Starting subtest: sync_expired_merge
[71.463398] Subtest sync_expired_merge: SUCCESS (1.074s)
[71.521987] [018/156] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[71.621225] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[75.335529] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.721s)
[76.528615] [019/156] (943s left) gen3_mixed_blits
[76.638734] [020/156] (943s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[76.739560] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[76.743828] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[76.838922] [021/156] (943s left) kms_atomic_transition (modeset-transition)
[76.938079] Starting subtest: modeset-transition
[76.940493] Starting dynamic subtest: 1x-outputs
[88.055964] Dynamic subtest 1x-outputs: SUCCESS (11.119s)
[88.058659] Subtest modeset-transition: SUCCESS (11.119s)
[88.915384] [022/156] (931s left) perf_pmu (init-wait)
[88.954862] Starting subtest: init-wait
[88.957307] Starting dynamic subtest: rcs0
[88.959626] Dynamic subtest rcs0: SUCCESS (0.001s)
[88.969640] Starting dynamic subtest: bcs0
[88.971772] Dynamic subtest bcs0: SUCCESS (0.000s)
[88.982410] Starting dynamic subtest: vcs0
[88.984430] Dynamic subtest vcs0: SUCCESS (0.000s)
[88.991945] Starting dynamic subtest: vcs1
[88.993924] Dynamic subtest vcs1: SUCCESS (0.000s)
[89.001592] Starting dynamic subtest: vecs0
[89.003799] Dynamic subtest vecs0: SUCCESS (0.000s)
[89.011275] Starting dynamic subtest: ccs0
[89.013203] Dynamic subtest ccs0: SUCCESS (0.000s)
[89.015059] Subtest init-wait: SUCCESS (0.005s)
[89.053136] [023/156] (931s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[89.147219] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[89.151365] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[89.237659] [024/156] (931s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[89.335483] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[89.339623] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[89.425159] [025/156] (931s left) gem_pxp (protected-raw-src-copy-not-readible)
[89.537954] Starting subtest: protected-raw-src-copy-not-readible
[89.609083] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.073s)
[89.734868] [026/156] (930s left) kms_color (ctm-signed)
[89.820500] Starting subtest: ctm-signed
[89.822468] Starting dynamic subtest: pipe-A-eDP-1
[92.035080] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.216s)
[92.043679] Starting dynamic subtest: pipe-B-eDP-1
[94.875714] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.839s)
[94.885227] Starting dynamic subtest: pipe-C-eDP-1
[97.600075] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.723s)
[97.609372] Starting dynamic subtest: pipe-D-eDP-1
[100.275089] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.675s)
[100.277540] Subtest ctm-signed: SUCCESS (10.455s)
[101.093371] [027/156] (919s left) kms_cursor_edge_walk (128x128-right-edge)
[101.194191] Starting subtest: 128x128-right-edge
[101.196669] Starting dynamic subtest: pipe-A-eDP-1
[104.668050] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[104.678057] Starting dynamic subtest: pipe-D-eDP-1
[107.888377] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.220s)
[107.890862] Subtest 128x128-right-edge: SUCCESS (6.696s)
[108.688680] [028/156] (912s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[108.793415] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[108.797743] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[108.886810] [029/156] (911s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[108.979398] Starting subtest: primary-yf-tiled-reflect-x-270
[108.984066] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[109.064661] [030/156] (911s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[109.169344] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[109.804335] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[109.977580] [031/156] (910s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[110.070648] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[110.075203] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[110.190912] [032/156] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[110.289312] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[110.293528] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[110.373788] [033/156] (910s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[110.470187] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[110.472537] Starting dynamic subtest: pipe-A-eDP-1
[110.495575] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[110.505734] Starting dynamic subtest: pipe-B-eDP-1
[110.527713] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[110.535558] Starting dynamic subtest: pipe-C-eDP-1
[110.557184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[110.565061] Starting dynamic subtest: pipe-D-eDP-1
[110.586939] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[110.591598] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[112.759379] [034/156] (908s left) fbdev (unaligned-write)
[112.799598] Starting subtest: unaligned-write
[112.899077] Subtest unaligned-write: SUCCESS (0.099s)
[112.964262] [035/156] (908s left) gem_eio (throttle)
[113.177226] Starting subtest: throttle
[113.484044] Subtest throttle: SUCCESS (0.306s)
[113.610070] [036/156] (907s left) kms_psr (pr-cursor-mmap-cpu)
[113.696241] Starting subtest: pr-cursor-mmap-cpu
[113.699968] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[113.770249] [037/156] (907s left) gem_mmap_offset (close-race)
[113.830305] Starting subtest: close-race
[133.943382] Subtest close-race: SUCCESS (20.110s)
[134.077155] [038/156] (887s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[134.180862] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[134.183260] Starting dynamic subtest: pipe-A-eDP-1
[134.275083] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[134.289382] Starting dynamic subtest: pipe-B-eDP-1
[135.429973] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[135.435185] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.254s)
[136.631508] [039/156] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[136.728282] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[140.655707] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.934s)
[141.831503] [040/156] (879s left) gem_ctx_create (basic)
[141.888084] Starting subtest: basic
[141.890550] Subtest basic: SUCCESS (0.000s)
[142.065668] [041/156] (879s left) gem_madvise (dontneed-before-pwrite)
[142.097689] Starting subtest: dontneed-before-pwrite
[142.117320] Subtest dontneed-before-pwrite: SKIP (0.017s)
[142.180885] [042/156] (879s left) kms_psr (fbc-psr2-basic)
[142.269135] Starting subtest: fbc-psr2-basic
[142.271086] Starting dynamic subtest: eDP-1
[142.275225] Dynamic subtest eDP-1: SKIP (0.000s)
[142.279336] Subtest fbc-psr2-basic: SKIP (0.001s)
[142.337704] [043/156] (878s left) i915_drm_fdinfo (all-busy-check-all)
[142.378090] Starting subtest: all-busy-check-all
[142.382442] Subtest all-busy-check-all: SKIP (0.003s)
[142.463313] [044/156] (878s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[142.577642] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[142.580100] Starting dynamic subtest: pipe-A-eDP-1
[142.605096] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[142.615372] Starting dynamic subtest: pipe-B-eDP-1
[142.638535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[142.647778] Starting dynamic subtest: pipe-C-eDP-1
[142.671692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[142.680923] Starting dynamic subtest: pipe-D-eDP-1
[142.704754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[142.709182] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[144.875075] [045/156] (876s left) kms_hdr (invalid-hdr)
[144.971375] Starting subtest: invalid-hdr
[144.973704] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[150.098089] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.122s)
[150.115281] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[154.182807] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.072s)
[154.194395] Subtest invalid-hdr: SUCCESS (9.225s)
[154.298400] [046/156] (867s left) kms_pm_backlight (fade-with-suspend)
[154.390215] Starting subtest: fade-with-suspend
[171.893062] Starting dynamic subtest: eDP-1
[174.904162] Dynamic subtest eDP-1: SUCCESS (3.065s)
[174.906152] Subtest fade-with-suspend: SUCCESS (5.431s)
[175.742951] [047/156] (845s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[175.813999] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[175.818697] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[176.011322] [048/156] (845s left) kms_invalid_mode (bad-htotal)
[176.112499] Starting subtest: bad-htotal
[176.114860] Starting dynamic subtest: pipe-A-eDP-1
[176.389809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[176.398892] Starting dynamic subtest: pipe-B-eDP-1
[176.401023] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[176.409538] Starting dynamic subtest: pipe-C-eDP-1
[176.411753] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[176.419934] Starting dynamic subtest: pipe-D-eDP-1
[176.421892] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[176.424266] Subtest bad-htotal: SUCCESS (0.288s)
[177.249489] [049/156] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[177.348835] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[180.860397] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.552s)
[182.003606] [050/156] (839s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[182.111516] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[182.115867] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[182.225471] [051/156] (839s left) gem_exec_whisper (basic-fds-forked-all)
[182.284555] Starting subtest: basic-fds-forked-all
[202.516844] Subtest basic-fds-forked-all: SUCCESS (20.279s)
[202.700405] [052/156] (818s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[202.811274] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[202.815858] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[202.912681] [053/156] (818s left) gem_spin_batch (resubmit)
[202.969667] Starting subtest: resubmit
[202.971947] Starting dynamic subtest: rcs0
[202.978221] Dynamic subtest rcs0: SUCCESS (0.008s)
[202.993920] Starting dynamic subtest: bcs0
[202.996210] Dynamic subtest bcs0: SUCCESS (0.003s)
[203.005998] Starting dynamic subtest: vcs0
[203.007947] Dynamic subtest vcs0: SUCCESS (0.003s)
[203.017202] Starting dynamic subtest: vcs1
[203.019125] Dynamic subtest vcs1: SUCCESS (0.002s)
[203.028295] Starting dynamic subtest: vecs0
[203.030191] Dynamic subtest vecs0: SUCCESS (0.003s)
[203.039198] Starting dynamic subtest: ccs0
[203.041115] Dynamic subtest ccs0: SUCCESS (0.002s)
[203.043002] Subtest resubmit: SUCCESS (0.024s)
[203.212429] [054/156] (818s left) gem_exec_fence (syncobj-channel)
[203.718726] Starting subtest: syncobj-channel
[204.737370] Subtest syncobj-channel: SUCCESS (1.016s)
[205.483674] [055/156] (816s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[205.583151] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[205.587514] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[205.685380] [056/156] (816s left) syncobj_timeline (etime-multi-wait-all-submitted)
[205.740163] Starting subtest: etime-multi-wait-all-submitted
[205.843229] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[205.919828] [057/156] (815s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[206.021238] Starting subtest: yf-tiled-8bpp-rotate-180
[206.025567] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[206.114235] [058/156] (815s left) gem_exec_async (forked-writes)
[206.178394] Starting subtest: forked-writes
[206.180660] Starting dynamic subtest: rcs0
[206.209607] Dynamic subtest rcs0: SUCCESS (0.031s)
[206.221543] Starting dynamic subtest: bcs0
[206.231622] Dynamic subtest bcs0: SUCCESS (0.021s)
[206.242597] Starting dynamic subtest: vcs0
[206.254104] Dynamic subtest vcs0: SUCCESS (0.021s)
[206.266840] Starting dynamic subtest: vcs1
[206.277515] Dynamic subtest vcs1: SUCCESS (0.023s)
[206.288766] Starting dynamic subtest: vecs0
[206.299197] Dynamic subtest vecs0: SUCCESS (0.021s)
[206.311194] Starting dynamic subtest: ccs0
[206.326301] Dynamic subtest ccs0: SUCCESS (0.026s)
[206.328451] Subtest forked-writes: SUCCESS (0.148s)
[206.544357] [059/156] (815s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[206.635460] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[206.640109] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[206.707872] [060/156] (815s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[206.762563] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[206.764608] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[206.851937] [061/156] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[206.955383] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[206.959542] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[207.043320] [062/156] (815s left) kms_chamelium_hpd (dp-hpd-storm)
[207.441317] Subtest dp-hpd-storm: SKIP (0.000s)
[208.250390] [063/156] (813s left) kms_big_fb (4-tiled-addfb)
[208.344573] Starting subtest: 4-tiled-addfb
[208.346891] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[208.444653] [064/156] (813s left) gen7_exec_parse (oacontrol-tracking)
[208.496752] Subtest oacontrol-tracking: SKIP (0.000s)
[208.565410] [065/156] (813s left) gem_caching (reads)
[208.621559] Subtest reads: SKIP (0.000s)
[208.697949] [066/156] (813s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[208.800187] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[208.804699] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[208.909178] [067/156] (813s left) i915_suspend (basic-s3-without-i915)
[208.946886] Starting subtest: basic-s3-without-i915
[210.797941] Subtest basic-s3-without-i915: SKIP (1.846s)
[212.367292] [068/156] (809s left) gem_create (create-ext-placement-sanity-check)
[212.553133] Starting subtest: create-ext-placement-sanity-check
[212.555808] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[212.658486] [069/156] (809s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[212.744515] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[212.746936] Starting dynamic subtest: pipe-A-eDP-1
[212.756530] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[212.767005] Starting dynamic subtest: pipe-B-eDP-1
[212.776391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[212.785927] Starting dynamic subtest: pipe-C-eDP-1
[212.794796] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[212.803461] Starting dynamic subtest: pipe-D-eDP-1
[212.812301] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[212.816684] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[215.000919] [070/156] (807s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[215.105032] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[215.109143] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[215.209827] [071/156] (807s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[215.305171] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[222.320784] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.022s)
[222.468830] [072/156] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[222.563914] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[222.568482] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[222.685781] [073/156] (799s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[222.802400] Starting subtest: 2x-cursor-vs-flip-atomic
[222.806747] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[222.946768] [074/156] (799s left) prime_vgem (basic-read)
[223.019541] Starting subtest: basic-read
[223.028792] Subtest basic-read: SKIP (0.006s)
[223.136962] [075/156] (799s left) kms_draw_crc (draw-method-render)
[223.229148] Starting subtest: draw-method-render
[223.231073] Starting dynamic subtest: xrgb8888-untiled
[223.496793] Dynamic subtest xrgb8888-untiled: SUCCESS (0.269s)
[223.506556] Starting dynamic subtest: rgb565-untiled
[223.719281] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[223.729052] Starting dynamic subtest: xrgb2101010-untiled
[223.940835] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[223.950886] Starting dynamic subtest: xbgr16161616f-untiled
[224.174336] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[224.184271] Starting dynamic subtest: xrgb8888-xtiled
[224.296308] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[224.305940] Starting dynamic subtest: rgb565-xtiled
[224.418738] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[224.428181] Starting dynamic subtest: xrgb2101010-xtiled
[224.540733] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[224.550070] Starting dynamic subtest: xbgr16161616f-xtiled
[224.674115] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[224.683258] Starting dynamic subtest: xrgb8888-4tiled
[224.796170] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[224.806123] Starting dynamic subtest: rgb565-4tiled
[224.919990] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[224.929239] Starting dynamic subtest: xrgb2101010-4tiled
[225.041105] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[225.052108] Starting dynamic subtest: xbgr16161616f-4tiled
[225.173874] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[225.175800] Subtest draw-method-render: SUCCESS (1.947s)
[225.279585] [076/156] (797s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[225.378204] Starting subtest: fbcpsr-tiling-y
[225.381594] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[225.475090] [077/156] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[225.565910] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[232.482640] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.921s)
[232.631655] [078/156] (790s left) gem_exec_balancer (nop)
[232.696682] Starting subtest: nop
[279.268900] Subtest nop: SUCCESS (46.580s)
[279.563497] [079/156] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[279.671348] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[279.675469] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[279.766161] [080/156] (743s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[279.860295] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[279.864604] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[279.945752] [081/156] (742s left) gem_ctx_isolation (dirty-switch)
[280.006991] Starting subtest: dirty-switch
[280.009395] Starting dynamic subtest: rcs0
[280.212922] Dynamic subtest rcs0: SUCCESS (0.205s)
[280.224798] Starting dynamic subtest: bcs0
[280.439485] Dynamic subtest bcs0: SUCCESS (0.224s)
[280.451921] Starting dynamic subtest: vcs0
[280.671301] Dynamic subtest vcs0: SUCCESS (0.231s)
[280.680669] Starting dynamic subtest: vcs1
[282.663530] Dynamic subtest vcs1: SUCCESS (1.990s)
[282.675746] Starting dynamic subtest: vecs0
[284.662787] Dynamic subtest vecs0: SUCCESS (1.998s)
[284.675201] Starting dynamic subtest: ccs0
[286.649183] Dynamic subtest ccs0: SUCCESS (1.984s)
[286.652778] Subtest dirty-switch: SUCCESS (6.640s)
[286.887305] [082/156] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[286.984637] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[294.389849] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.409s)
[294.526960] [083/156] (728s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[294.829354] Starting subtest: cursor-rapid-movement-max-size
[294.835943] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[294.961748] [084/156] (728s left) core_getclient (basic)
[295.012634] Starting subtest: basic
[295.014884] Subtest basic: SUCCESS (0.000s)
[295.114721] [085/156] (727s left) kms_addfb_basic (unused-modifier)
[295.160095] Starting subtest: unused-modifier
[295.162478] Subtest unused-modifier: SUCCESS (0.000s)
[295.307318] [086/156] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[295.418552] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[302.440572] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.026s)
[302.565554] [087/156] (720s left) kms_busy (basic-hang)
[302.661193] Starting subtest: basic-hang
[302.663524] Starting dynamic subtest: flip-pipe-A
[303.256879] Dynamic subtest flip-pipe-A: SUCCESS (0.595s)
[303.267807] Starting dynamic subtest: modeset-pipe-A
[306.903993] Dynamic subtest modeset-pipe-A: SUCCESS (3.646s)
[306.915265] Starting dynamic subtest: flip-pipe-D
[308.119719] Dynamic subtest flip-pipe-D: SUCCESS (1.215s)
[308.130697] Starting dynamic subtest: modeset-pipe-D
[311.537476] Dynamic subtest modeset-pipe-D: SUCCESS (3.414s)
[311.539729] Subtest basic-hang: SUCCESS (8.876s)
[312.342499] [088/156] (710s left) syncobj_basic (bad-handle-to-fd)
[312.392609] Starting subtest: bad-handle-to-fd
[312.394582] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[312.490749] [089/156] (710s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[312.547780] Starting subtest: multi-wait-all-for-submit-available-signaled
[312.549800] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[312.663346] [090/156] (710s left) gem_exec_schedule (implicit-write-read)
[312.735916] Starting subtest: implicit-write-read
[312.738127] Starting dynamic subtest: rcs0
[312.851489] Dynamic subtest rcs0: SUCCESS (0.122s)
[312.864109] Starting dynamic subtest: vcs0
[312.938667] Dynamic subtest vcs0: SUCCESS (0.087s)
[312.952499] Starting dynamic subtest: vcs1
[313.021980] Dynamic subtest vcs1: SUCCESS (0.082s)
[313.040759] Starting dynamic subtest: vecs0
[313.096303] Dynamic subtest vecs0: SUCCESS (0.074s)
[313.105864] Starting dynamic subtest: ccs0
[313.182076] Dynamic subtest ccs0: SUCCESS (0.085s)
[313.184405] Subtest implicit-write-read: SUCCESS (0.453s)
[314.559040] [091/156] (708s left) gem_lmem_swapping (heavy-random)
[314.600329] Subtest heavy-random: SKIP (0.000s)
[314.642430] [092/156] (708s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[314.741125] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[314.745196] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[314.813105] [093/156] (708s left) gem_userptr_blits (sync-unmap)
[314.878900] Starting subtest: sync-unmap
[314.893519] Subtest sync-unmap: SUCCESS (0.012s)
[315.007886] [094/156] (708s left) kms_chamelium_edid (hdmi-mode-timings)
[315.397735] Subtest hdmi-mode-timings: SKIP (0.000s)
[316.252653] [095/156] (707s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[316.348674] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[316.352897] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[316.466418] [096/156] (707s left) sw_sync (alloc_timeline)
[316.504281] Starting subtest: alloc_timeline
[316.506563] Subtest alloc_timeline: SUCCESS (0.000s)
[316.558434] [097/156] (707s left) i915_pm_freq_mult (media-freq)
[316.613960] Starting subtest: media-freq
[316.616390] Starting dynamic subtest: gt0
[316.620618] Dynamic subtest gt0: SKIP (0.000s)
[316.631629] Starting dynamic subtest: gt1
[316.635743] Dynamic subtest gt1: SKIP (0.000s)
[316.639867] Subtest media-freq: SKIP (0.001s)
[316.716541] [098/156] (706s left) sysfs_timeslice_duration (duration)
[316.766449] Starting subtest: duration
[316.768805] Starting dynamic subtest: vecs0
[330.365495] Dynamic subtest vecs0: SUCCESS (13.598s)
[330.378661] Starting dynamic subtest: ccs0
[343.503146] Dynamic subtest ccs0: SUCCESS (13.139s)
[343.515596] Starting dynamic subtest: vcs0
[357.374123] Dynamic subtest vcs0: SUCCESS (13.870s)
[357.386752] Starting dynamic subtest: bcs0
[370.516134] Dynamic subtest bcs0: SUCCESS (13.143s)
[370.530934] Starting dynamic subtest: rcs0
[383.652235] Dynamic subtest rcs0: SUCCESS (13.138s)
[383.664547] Starting dynamic subtest: vcs1
[398.334697] Dynamic subtest vcs1: SUCCESS (14.680s)
[398.337377] Subtest duration: SUCCESS (81.584s)
[398.417235] [099/156] (625s left) kms_rotation_crc (multiplane-rotation)
[398.509166] Starting subtest: multiplane-rotation
[415.950641] Subtest multiplane-rotation: SUCCESS (17.438s)
[416.066201] [100/156] (607s left) kms_pm_rpm (legacy-planes-dpms)
[417.594952] Starting subtest: legacy-planes-dpms
[417.597531] Starting dynamic subtest: plane-65
[425.934302] Dynamic subtest plane-65: SUCCESS (8.340s)
[425.947114] Starting dynamic subtest: plane-95
[434.272793] Dynamic subtest plane-95: SUCCESS (8.335s)
[434.287012] Starting dynamic subtest: plane-125
[442.565953] Dynamic subtest plane-125: SUCCESS (8.289s)
[442.580172] Starting dynamic subtest: plane-135
[451.005891] Dynamic subtest plane-135: SUCCESS (8.435s)
[451.008856] Subtest legacy-planes-dpms: SUCCESS (33.410s)
[451.410983] [101/156] (572s left) kms_lease (simple-lease)
[451.497301] Starting subtest: simple-lease
[451.499657] Starting dynamic subtest: pipe-A-eDP-1
[452.001588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[452.012401] Starting dynamic subtest: pipe-B-eDP-1
[453.423718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[453.433644] Starting dynamic subtest: pipe-C-eDP-1
[454.926880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s)
[454.939860] Starting dynamic subtest: pipe-D-eDP-1
[456.340693] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[456.343369] Subtest simple-lease: SUCCESS (4.845s)
[457.146650] [102/156] (566s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[457.252296] Starting subtest: pr-cursor-plane-move-continuous-sf
[457.256737] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[457.332922] [103/156] (566s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[457.433472] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[457.435705] Starting dynamic subtest: pipe-A-eDP-1
[457.887125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[457.898968] Starting dynamic subtest: pipe-B-eDP-1
[459.279771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[459.290816] Starting dynamic subtest: pipe-C-eDP-1
[460.676588] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[460.688842] Starting dynamic subtest: pipe-D-eDP-1
[462.012548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[462.014878] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.552s)
[463.203864] [104/156] (560s left) gem_pxp (create-protected-buffer)
[463.319259] Starting subtest: create-protected-buffer
[463.321931] Subtest create-protected-buffer: SUCCESS (0.000s)
[463.425528] [105/156] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[463.521127] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[463.525266] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[463.609180] [106/156] (560s left) kms_psr (psr2-sprite-mmap-cpu)
[463.696664] Starting subtest: psr2-sprite-mmap-cpu
[463.698944] Starting dynamic subtest: eDP-1
[465.422821] Dynamic subtest eDP-1: SUCCESS (1.727s)
[465.425148] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.728s)
[466.302043] [107/156] (557s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[466.397147] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[470.806828] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.415s)
[471.973273] [108/156] (552s left) gem_madvise (dontneed-before-mmap)
[472.007965] Starting subtest: dontneed-before-mmap
[472.026168] Subtest dontneed-before-mmap: SUCCESS (0.022s)
[472.138149] [109/156] (551s left) kms_flip (2x-flip-vs-panning-vs-hang)
[472.238361] Starting subtest: 2x-flip-vs-panning-vs-hang
[472.242675] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[472.366723] [110/156] (551s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[472.433930] Starting subtest: map-fixed-invalidate-overlap
[472.438353] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[472.541997] [111/156] (551s left) kms_flip (blocking-wf_vblank)
[472.639774] Starting subtest: blocking-wf_vblank
[472.642241] Starting dynamic subtest: A-eDP1
[481.614830] Dynamic subtest A-eDP1: SUCCESS (8.974s)
[481.627121] Starting dynamic subtest: B-eDP1
[490.544075] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[490.554725] Starting dynamic subtest: C-eDP1
[499.468681] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[499.482025] Starting dynamic subtest: D-eDP1
[508.397066] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[508.401962] Subtest blocking-wf_vblank: SUCCESS (35.764s)
[509.641104] [112/156] (514s left) kms_plane_multiple (tiling-y)
[509.757103] Starting subtest: tiling-y
[509.761727] Subtest tiling-y: SKIP (0.000s)
[509.829204] [113/156] (514s left) drm_mm (drm_mm)
[509.864256] Starting subtest: drm_mm
[509.896330] Starting dynamic subtest: drm_test_mm_init
[510.023585] Dynamic subtest drm_test_mm_init: SUCCESS (0.128s)
[510.034429] Starting dynamic subtest: drm_test_mm_debug
[510.134482] Dynamic subtest drm_test_mm_debug: SUCCESS (0.111s)
[510.143888] Starting dynamic subtest: drm_test_mm_align32
[510.233309] Dynamic subtest drm_test_mm_align32: SUCCESS (0.099s)
[510.242469] Starting dynamic subtest: drm_test_mm_align64
[510.330480] Dynamic subtest drm_test_mm_align64: SUCCESS (0.097s)
[510.339780] Starting dynamic subtest: drm_test_mm_lowest
[510.435588] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.104s)
[510.444808] Starting dynamic subtest: drm_test_mm_highest
[510.542308] Dynamic subtest drm_test_mm_highest: SUCCESS (0.106s)
[510.544239] Subtest drm_mm: SUCCESS (0.679s)
[510.703636] [114/156] (513s left) kms_psr (pr-sprite-mmap-cpu)
[510.794473] Starting subtest: pr-sprite-mmap-cpu
[510.798476] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[510.867209] [115/156] (513s left) kms_addfb_basic (legacy-format)
[510.918909] Starting subtest: legacy-format
[510.946355] Subtest legacy-format: SUCCESS (0.023s)
[511.095033] [116/156] (513s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[511.193351] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[515.737408] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.549s)
[516.924406] [117/156] (507s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[517.017712] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[517.028732] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[517.124955] [118/156] (507s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[517.237198] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[517.241304] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[517.353488] [119/156] (507s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[517.460243] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[517.464236] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[517.570228] [120/156] (506s left) perf_pmu (busy)
[517.609081] Starting subtest: busy
[517.611436] Starting dynamic subtest: rcs0
[518.198035] Dynamic subtest rcs0: SUCCESS (0.591s)
[518.212023] Starting dynamic subtest: bcs0
[518.761012] Dynamic subtest bcs0: SUCCESS (0.561s)
[518.773346] Starting dynamic subtest: vcs0
[520.415977] Dynamic subtest vcs0: SUCCESS (1.652s)
[520.428660] Starting dynamic subtest: vcs1
[522.464829] Dynamic subtest vcs1: SUCCESS (2.046s)
[522.477561] Starting dynamic subtest: vecs0
[524.448451] Dynamic subtest vecs0: SUCCESS (1.981s)
[524.461499] Starting dynamic subtest: ccs0
[525.016844] Dynamic subtest ccs0: SUCCESS (0.567s)
[525.019418] Subtest busy: SUCCESS (7.412s)
[525.108346] [121/156] (499s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[525.241497] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[543.666842] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.427s)
[544.465041] [122/156] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[544.574922] Starting subtest: fbcpsr-2p-rte
[544.579274] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[544.690605] [123/156] (479s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[544.792671] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[544.797036] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[544.897538] [124/156] (479s left) gem_exec_balancer (parallel-keep-in-fence)
[545.162816] Starting subtest: parallel-keep-in-fence
[546.237485] Subtest parallel-keep-in-fence: SUCCESS (1.079s)
[546.347619] [125/156] (478s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[546.437378] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[546.441416] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[546.518387] [126/156] (478s left) kms_plane (plane-panning-bottom-right-suspend)
[546.616942] Starting subtest: plane-panning-bottom-right-suspend
[546.619204] Starting dynamic subtest: pipe-A
[564.281131] Dynamic subtest pipe-A: SUCCESS (3.619s)
[564.293201] Starting dynamic subtest: pipe-B
[583.291156] Dynamic subtest pipe-B: SUCCESS (3.528s)
[583.293139] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.151s)
[584.157789] [127/156] (440s left) kms_psr2_su (page_flip-nv12)
[584.220227] Subtest page_flip-NV12: SKIP (0.000s)
[584.285791] [128/156] (440s left) kms_vrr (flip-basic-fastset)
[584.385280] Starting subtest: flip-basic-fastset
[584.391592] Subtest flip-basic-fastset: SKIP (0.000s)
[584.469212] [129/156] (440s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[584.580500] Starting subtest: 2x-cursor-vs-flip-legacy
[584.584947] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[584.723824] [130/156] (440s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[584.828618] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[584.832429] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[584.950556] [131/156] (440s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[585.037068] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[585.039154] Starting dynamic subtest: pipe-A-eDP-1
[585.061117] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[585.073383] Starting dynamic subtest: pipe-B-eDP-1
[585.090223] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[585.099498] Starting dynamic subtest: pipe-C-eDP-1
[585.116928] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[585.126323] Starting dynamic subtest: pipe-D-eDP-1
[585.144254] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[585.147566] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[587.288692] [132/156] (437s left) sw_sync (sync_merge)
[587.328976] Starting subtest: sync_merge
[587.331208] Subtest sync_merge: SUCCESS (0.000s)
[587.388546] [133/156] (437s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-pwrite)
[587.487201] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-pwrite
[587.491384] Subtest fbchdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[587.577601] [134/156] (437s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[587.668429] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[587.672238] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[587.777566] [135/156] (437s left) kms_pm_rpm (modeset-non-lpsp-stress)
[589.314733] Starting subtest: modeset-non-lpsp-stress
[590.478266] Subtest modeset-non-lpsp-stress: SKIP (1.175s)
[590.865620] [136/156] (434s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[590.974986] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[590.979188] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[591.087541] [137/156] (434s left) gem_partial_pwrite_pread (write)
[591.142832] Subtest write: SKIP (0.000s)
[591.211550] [138/156] (434s left) prime_vgem (basic-blt)
[591.288433] Starting subtest: basic-blt
[591.313171] Subtest basic-blt: SUCCESS (0.027s)
[591.441873] [139/156] (433s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen)
[591.530022] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen
[591.534089] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[591.631258] [140/156] (433s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[591.739996] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[591.744075] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[591.839441] [141/156] (433s left) gem_userptr_blits (map-fixed-invalidate-busy)
[591.902937] Starting subtest: map-fixed-invalidate-busy
[591.906235] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[592.022643] [142/156] (433s left) i915_pm_rpm (system-suspend-execbuf)
[594.238569] Starting subtest: system-suspend-execbuf
[653.705195] Subtest system-suspend-execbuf: SUCCESS (44.079s)
[654.108059] [143/156] (371s left) kms_plane_lowres (tiling-none)
[654.197117] Starting subtest: tiling-none
[654.199904] Starting dynamic subtest: pipe-A-eDP-1
[654.204993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[654.498361] Starting dynamic subtest: pipe-B-eDP-1
[654.503644] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[654.515495] Starting dynamic subtest: pipe-C-eDP-1
[654.520962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[654.531920] Starting dynamic subtest: pipe-D-eDP-1
[654.537754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[654.543036] Subtest tiling-none: SKIP (0.299s)
[655.316547] [144/156] (370s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[655.417282] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[655.422864] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[655.524262] [145/156] (370s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[655.623543] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[655.628171] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[655.719712] [146/156] (369s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[655.839406] Starting subtest: short-flip-before-cursor-toggle
[656.750956] Subtest short-flip-before-cursor-toggle: SUCCESS (0.912s)
[657.649179] [147/156] (368s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[657.743910] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[657.748958] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[657.844068] [148/156] (367s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[657.950970] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[664.974006] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.030s)
[665.114223] [149/156] (360s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[665.168134] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[665.170699] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[665.260406] [150/156] (360s left) gem_exec_schedule (fairslice)
[665.329164] Starting subtest: fairslice
[665.331687] Starting dynamic subtest: rcs0
[667.342143] Dynamic subtest rcs0: SUCCESS (2.020s)
[667.352639] Starting dynamic subtest: bcs0
[669.364022] Dynamic subtest bcs0: SUCCESS (2.021s)
[669.376512] Starting dynamic subtest: vcs0
[671.386085] Dynamic subtest vcs0: SUCCESS (2.020s)
[671.399878] Starting dynamic subtest: vcs1
[673.405182] Dynamic subtest vcs1: SUCCESS (2.019s)
[673.417159] Starting dynamic subtest: vecs0
[675.426283] Dynamic subtest vecs0: SUCCESS (2.020s)
[675.437626] Starting dynamic subtest: ccs0
[677.451025] Dynamic subtest ccs0: SUCCESS (2.026s)
[677.453871] Subtest fairslice: SUCCESS (12.133s)
[677.752384] [151/156] (348s left) gem_wait (invalid-buf)
[677.800855] Starting subtest: invalid-buf
[677.803174] Subtest invalid-buf: SUCCESS (0.000s)
[678.023025] [152/156] (347s left) gem_pread (display)
[678.072631] Subtest display: SKIP (0.000s)
[678.136843] [153/156] (347s left) gem_exec_schedule (semaphore-noskip)
[678.211609] Starting subtest: semaphore-noskip
[678.715867] Subtest semaphore-noskip: SUCCESS (0.512s)
[679.064555] [154/156] (346s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[679.165632] Starting subtest: y-tiled-32bpp-rotate-180
[679.170170] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[679.270058] [155/156] (346s left) api_intel_allocator (two-level-inception-interruptible)
[679.319289] Starting subtest: two-level-inception-interruptible
[684.722105] Subtest two-level-inception-interruptible: SUCCESS (5.405s)
[684.849228] [156/156] (341s left) gem_exec_flush (basic-wb-pro-default)
[684.920157] Starting subtest: basic-wb-pro-default
[690.395158] Subtest basic-wb-pro-default: SUCCESS (5.477s)
[690.581089] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_gtt_cpu_tlb
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: kms_debugfs
results: parsing output: 10/ for test: gen7_exec_parse
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gen3_mixed_blits
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_pxp
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: fbdev
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_mmap_offset
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_ctx_create
results: parsing output: 40/ for test: gem_madvise
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_hdr
results: parsing output: 45/ for test: kms_pm_backlight
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_async
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gen7_exec_parse
results: parsing output: 64/ for test: gem_caching
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_suspend
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: prime_vgem
results: parsing output: 74/ for test: kms_draw_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_ctx_isolation
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: core_getclient
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_busy
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: i915_pm_freq_mult
results: parsing output: 97/ for test: sysfs_timeslice_duration
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_madvise
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_plane_multiple
results: parsing output: 112/ for test: drm_mm
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_psr2_su
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: sw_sync
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_pm_rpm
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_partial_pwrite_pread
results: parsing output: 137/ for test: prime_vgem
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_userptr_blits
results: parsing output: 141/ for test: i915_pm_rpm
results: parsing output: 142/ for test: kms_plane_lowres
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_cursor_legacy
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: syncobj_timeline
results: parsing output: 149/ for test: gem_exec_schedule
results: parsing output: 150/ for test: gem_wait
results: parsing output: 151/ for test: gem_pread
results: parsing output: 152/ for test: gem_exec_schedule
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: api_intel_allocator
results: parsing output: 155/ for test: gem_exec_flush
Done.