[57.904960] Initializing watchdogs
[57.905022]   /dev/watchdog0
[57.920163] [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.924870] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.927105] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.930276] [001/155] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[58.051350] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[62.458956] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.405s)
[63.700211] [002/155] (954s left) gem_ctx_param (invalid-param-set)
[63.750882] Starting subtest: invalid-param-set
[63.753245] Subtest invalid-param-set: SUCCESS (0.000s)
[63.837126] [003/155] (954s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[63.896856] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[63.951604] [004/155] (954s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[64.054385] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[64.058542] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.155442] [005/155] (954s left) kms_feature_discovery (psr2)
[64.240643] Starting subtest: psr2
[64.243036] Subtest psr2: SUCCESS (0.000s)
[64.308165] [006/155] (954s left) gem_pxp (verify-pxp-stale-ctx-execution)
[64.438681] Starting subtest: verify-pxp-stale-ctx-execution
[65.502794] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[65.605304] [007/155] (953s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[65.689730] Starting subtest: plane-all-transition-nonblocking-fencing
[65.692037] Starting dynamic subtest: pipe-A-eDP-1
[68.186064] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[68.504530] Starting dynamic subtest: pipe-B-eDP-1
[71.715489] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.218s)
[72.013760] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.318s)
[72.847273] [008/155] (945s left) kms_async_flips (invalid-async-flip-atomic)
[73.094801] Starting subtest: invalid-async-flip-atomic
[73.471926] Starting dynamic subtest: pipe-A-eDP-1
[74.284526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[74.641579] Starting dynamic subtest: pipe-B-eDP-1
[75.513507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.880s)
[75.888595] Starting dynamic subtest: pipe-C-eDP-1
[76.719292] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.837s)
[77.079077] Starting dynamic subtest: pipe-D-eDP-1
[77.853161] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[77.855480] Subtest invalid-async-flip-atomic: SUCCESS (4.757s)
[79.016216] [009/155] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[79.123570] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[79.127776] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[79.234111] [010/155] (939s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[79.326276] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[80.360382] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.034s)
[80.489635] [011/155] (938s left) api_intel_allocator (alloc-simple)
[80.544883] Starting subtest: alloc-simple
[80.546858] Subtest alloc-simple: SUCCESS (0.005s)
[80.665467] [012/155] (938s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[80.757767] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[80.761348] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[80.851700] [013/155] (938s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[80.949877] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[80.953397] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[81.043314] [014/155] (937s left) gem_mmap_offset (clear)
[81.101696] Starting subtest: clear
[81.104442] Starting dynamic subtest: smem0
[104.703778] Dynamic subtest smem0: SUCCESS (23.593s)
[104.705671] Subtest clear: SUCCESS (23.595s)
[104.840564] [015/155] (914s left) syncobj_timeline (invalid-signal-illegal-point)
[104.954392] Starting subtest: invalid-signal-illegal-point
[104.956852] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[105.058242] [016/155] (913s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[105.161261] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[112.160803] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.004s)
[112.259964] [017/155] (906s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[112.357776] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[112.360103] Starting dynamic subtest: pipe-A-eDP-1
[113.239858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s)
[113.249483] Starting dynamic subtest: pipe-B-eDP-1
[114.818595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.576s)
[114.828226] Starting dynamic subtest: pipe-C-eDP-1
[116.359145] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.538s)
[116.369055] Starting dynamic subtest: pipe-D-eDP-1
[117.895721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.536s)
[117.898214] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.530s)
[119.069641] [018/155] (900s left) gem_partial_pwrite_pread (write)
[119.122798] Subtest write: SKIP (0.000s)
[119.186144] [019/155] (899s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[119.577265] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[120.377210] [020/155] (898s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[120.475551] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[121.542776] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s)
[121.662774] [021/155] (897s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[121.726671] Starting subtest: y-tiled-to-vebox-y-tiled
[121.730461] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[121.907268] [022/155] (897s left) gem_userptr_blits (mmap-offset-banned)
[121.976873] Starting subtest: mmap-offset-banned
[121.979435] Starting dynamic subtest: wb
[121.981740] Dynamic subtest wb: SUCCESS (0.000s)
[121.992548] Starting dynamic subtest: wc
[121.994679] Dynamic subtest wc: SUCCESS (0.000s)
[122.003083] Starting dynamic subtest: uc
[122.005249] Dynamic subtest uc: SUCCESS (0.000s)
[122.007456] Subtest mmap-offset-banned: SUCCESS (0.002s)
[122.102450] [023/155] (897s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[122.205942] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[123.206875] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.001s)
[123.339197] [024/155] (895s left) kms_psr (psr2-cursor-mmap-cpu)
[123.427617] Starting subtest: psr2-cursor-mmap-cpu
[123.429946] Starting dynamic subtest: eDP-1
[125.184695] Dynamic subtest eDP-1: SUCCESS (1.756s)
[125.187341] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.757s)
[126.056360] [025/155] (893s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[126.164840] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[126.167255] Starting dynamic subtest: pipe-A-eDP-1
[126.176344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.187081] Starting dynamic subtest: pipe-B-eDP-1
[126.195706] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.204388] Starting dynamic subtest: pipe-C-eDP-1
[126.212722] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.221233] Starting dynamic subtest: pipe-D-eDP-1
[126.229740] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.234182] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[128.442963] [026/155] (890s left) kms_psr (fbc-pr-dpms)
[128.540516] Starting subtest: fbc-pr-dpms
[128.544793] Subtest fbc-pr-dpms: SKIP (0.000s)
[128.636354] [027/155] (890s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[128.734971] Starting subtest: plane-lut1d-post-ctm3x4
[128.859755] Starting dynamic subtest: pipe-A-plane-0
[129.058360] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[129.068662] Starting dynamic subtest: pipe-A-plane-1
[129.192217] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[129.201202] Starting dynamic subtest: pipe-A-plane-2
[129.324932] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[130.524319] Starting dynamic subtest: pipe-B-plane-0
[130.660667] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[130.669713] Starting dynamic subtest: pipe-B-plane-1
[130.793891] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[130.802786] Starting dynamic subtest: pipe-B-plane-2
[130.927601] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[132.161230] Starting dynamic subtest: pipe-C-plane-0
[132.287420] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[132.296710] Starting dynamic subtest: pipe-C-plane-1
[132.431149] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[132.441218] Starting dynamic subtest: pipe-C-plane-2
[132.578162] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[133.796868] Starting dynamic subtest: pipe-D-plane-0
[133.934212] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[133.943102] Starting dynamic subtest: pipe-D-plane-1
[134.067408] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[134.075966] Starting dynamic subtest: pipe-D-plane-2
[134.200986] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[134.487180] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.754s)
[135.390195] [028/155] (884s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[135.487846] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[135.492079] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[135.588502] [029/155] (883s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[135.681065] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[135.683355] Starting dynamic subtest: pipe-A-default-mode
[136.843428] Dynamic subtest pipe-A-default-mode: SKIP (1.160s)
[136.847981] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.162s)
[136.986096] [030/155] (882s left) sw_sync (sync_merge_same)
[137.027522] Starting subtest: sync_merge_same
[137.029697] Subtest sync_merge_same: SUCCESS (0.000s)
[137.082860] [031/155] (882s left) kms_big_fb (yf-tiled-addfb)
[137.179472] Starting subtest: yf-tiled-addfb
[137.183806] Subtest yf-tiled-addfb: SKIP (0.000s)
[137.283317] [032/155] (882s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[137.379792] Starting subtest: primary-y-tiled-reflect-x-90
[137.384292] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[137.462668] [033/155] (882s left) prime_mmap_coherency (ioctl-errors)
[137.516019] Starting subtest: ioctl-errors
[150.599939] Subtest ioctl-errors: SUCCESS (13.083s)
[150.789987] [034/155] (868s left) kms_psr (psr2-sprite-mmap-cpu)
[150.922184] Starting subtest: psr2-sprite-mmap-cpu
[150.924517] Starting dynamic subtest: eDP-1
[152.705992] Dynamic subtest eDP-1: SUCCESS (1.785s)
[152.708512] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.786s)
[153.581773] [035/155] (866s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[153.676292] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[153.680627] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[153.771259] [036/155] (866s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[153.865373] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[153.869684] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[153.963711] [037/155] (865s left) gem_softpin (evict-active-interruptible)
[154.037208] Starting subtest: evict-active-interruptible
[154.042811] Subtest evict-active-interruptible: SUCCESS (0.006s)
[154.152874] [038/155] (865s left) kms_plane_scaling (intel-max-src-size)
[154.240799] Starting subtest: intel-max-src-size
[154.247528] Subtest intel-max-src-size: SKIP (0.000s)
[154.326949] [039/155] (865s left) syncobj_timeline (multi-wait-signaled)
[154.396409] Starting subtest: multi-wait-signaled
[154.398768] Subtest multi-wait-signaled: SUCCESS (0.001s)
[154.500892] [040/155] (865s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[154.609374] Starting subtest: cursorA-vs-flipA-varying-size
[165.765880] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.156s)
[166.615434] [041/155] (853s left) syncobj_wait (invalid-single-wait-unsubmitted)
[166.670679] Starting subtest: invalid-single-wait-unsubmitted
[166.673032] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[166.767866] [042/155] (853s left) syncobj_timeline (etime-single-wait-all-submitted)
[166.828352] Starting subtest: etime-single-wait-all-submitted
[166.934465] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[167.011431] [043/155] (853s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[167.122799] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[167.127084] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[167.217644] [044/155] (852s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[167.318820] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[167.323079] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[167.425578] [045/155] (852s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[167.538485] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[167.543099] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[167.682116] [046/155] (852s left) syncobj_timeline (wait-delayed-signal)
[167.738164] Starting subtest: wait-delayed-signal
[167.838999] Subtest wait-delayed-signal: SUCCESS (0.102s)
[167.945045] [047/155] (852s left) gem_sync (basic-many-each)
[168.008034] Starting subtest: basic-many-each
[170.290149] Subtest basic-many-each: SUCCESS (2.289s)
[170.471861] [048/155] (849s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[170.568965] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[170.571338] Starting dynamic subtest: pipe-A-eDP-1
[170.594102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.603846] Starting dynamic subtest: pipe-B-eDP-1
[170.625605] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.634658] Starting dynamic subtest: pipe-C-eDP-1
[170.656279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.664821] Starting dynamic subtest: pipe-D-eDP-1
[170.687470] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.691659] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[172.871816] [049/155] (847s left) gem_render_copy_redux (flink)
[172.933579] Starting subtest: flink
[173.681555] Subtest flink: SUCCESS (0.748s)
[173.816934] [050/155] (846s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[173.913822] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[173.917194] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[174.006836] [051/155] (846s left) syncobj_timeline (wait-zero-handles)
[174.069438] Starting subtest: wait-zero-handles
[174.071505] Subtest wait-zero-handles: SUCCESS (0.000s)
[174.201197] [052/155] (846s left) gem_pxp (create-regular-context-2)
[174.268355] Starting subtest: create-regular-context-2
[174.270316] Subtest create-regular-context-2: SUCCESS (0.001s)
[174.361097] [053/155] (846s left) kms_rmfb (rmfb-ioctl)
[174.479323] Starting subtest: rmfb-ioctl
[174.481312] Starting dynamic subtest: pipe-A-eDP-1
[174.584283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[174.593080] Starting dynamic subtest: pipe-B-eDP-1
[175.745373] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[175.756738] Starting dynamic subtest: pipe-C-eDP-1
[176.950090] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[176.960436] Starting dynamic subtest: pipe-D-eDP-1
[178.101357] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[178.103666] Subtest rmfb-ioctl: SUCCESS (3.623s)
[179.301321] [054/155] (841s left) kms_selftest (drm_plane_helper)
[179.348023] Starting subtest: drm_plane_helper
[179.393927] Starting dynamic subtest: drm_test_check_plane_state
[179.494062] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.099s)
[179.502868] Starting dynamic subtest: drm_test_check_invalid_plane_state
[179.615949] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.119s)
[179.618515] Subtest drm_plane_helper: SUCCESS (0.266s)
[179.795352] [055/155] (840s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[179.905831] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[179.910217] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[180.000620] [056/155] (840s left) kms_flip (flip-vs-fences-interruptible)
[180.096746] Starting subtest: flip-vs-fences-interruptible
[180.101145] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[180.200654] [057/155] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[180.295798] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[180.300233] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[180.424557] [058/155] (840s left) gem_mmap_wc (close)
[180.482078] Subtest close: SKIP (0.000s)
[180.550312] [059/155] (840s left) kms_plane_scaling (2x-scaler-multi-pipe)
[180.630805] Starting subtest: 2x-scaler-multi-pipe
[180.635165] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[180.724787] [060/155] (840s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[182.450038] Starting subtest: dpms-mode-unset-lpsp
[186.542671] Subtest dpms-mode-unset-lpsp: SUCCESS (4.095s)
[186.947688] [061/155] (833s left) kms_vblank (ts-continuation-idle)
[187.036747] Starting subtest: ts-continuation-idle
[187.038735] Starting dynamic subtest: pipe-A-eDP-1
[187.437634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[187.451808] Starting dynamic subtest: pipe-D-eDP-1
[188.515479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.076s)
[188.517843] Subtest ts-continuation-idle: SUCCESS (1.480s)
[189.381864] [062/155] (831s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[189.484547] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[189.488777] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[189.573511] [063/155] (831s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[189.663842] Starting subtest: psr-rgb101010-draw-blt
[196.955567] Subtest psr-rgb101010-draw-blt: SUCCESS (7.297s)
[197.094389] [064/155] (823s left) kms_psr (fbc-psr-sprite-render)
[197.187886] Starting subtest: fbc-psr-sprite-render
[197.190203] Starting dynamic subtest: eDP-1
[197.194361] Dynamic subtest eDP-1: SKIP (0.000s)
[197.198663] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[197.259023] [065/155] (823s left) gem_ctx_shared (q-out-order)
[197.332431] Starting subtest: Q-out-order
[197.334693] Starting dynamic subtest: rcs0
[197.445444] Dynamic subtest rcs0: SUCCESS (0.112s)
[197.460889] Starting dynamic subtest: vcs0
[197.522718] Dynamic subtest vcs0: SUCCESS (0.076s)
[197.536728] Starting dynamic subtest: vcs1
[197.597816] Dynamic subtest vcs1: SUCCESS (0.075s)
[197.614505] Starting dynamic subtest: vecs0
[197.668640] Dynamic subtest vecs0: SUCCESS (0.070s)
[197.686094] Starting dynamic subtest: ccs0
[197.743640] Dynamic subtest ccs0: SUCCESS (0.074s)
[197.746204] Subtest Q-out-order: SUCCESS (0.411s)
[199.391145] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[199.394675] [066/155] (821s left) kms_plane_multiple (2x-tiling-x)
[199.481255] Starting subtest: 2x-tiling-x
[199.485764] Subtest 2x-tiling-x: SKIP (0.000s)
[199.555433] [067/155] (821s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[199.645836] Starting subtest: fbc-farfromfence-mmap-gtt
[199.650611] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[199.752349] [068/155] (821s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[199.871318] Starting subtest: cursorA-vs-flipA-atomic-transitions
[211.026853] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.155s)
[211.833039] [069/155] (809s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[213.463252] Starting subtest: gem-execbuf-stress-pc8
[213.515608] Subtest gem-execbuf-stress-pc8: SKIP (0.050s)
[214.073942] [070/155] (807s left) gem_eio (in-flight-contexts-10ms)
[214.297773] Starting subtest: in-flight-contexts-10ms
[228.314720] Subtest in-flight-contexts-10ms: SUCCESS (14.017s)
[228.486084] [071/155] (792s left) kms_chamelium_frames (dp-frame-dump)
[228.871456] Subtest dp-frame-dump: SKIP (0.000s)
[229.686641] [072/155] (791s left) gem_pwrite_snooped
[229.812721] [073/155] (791s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[229.917805] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[229.922164] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[230.024907] [074/155] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[230.120871] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[230.125291] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[230.240529] [075/155] (791s left) gen7_exec_parse (chained-batch)
[230.308109] Subtest chained-batch: SKIP (0.000s)
[230.372551] [076/155] (791s left) core_debugfs (read-all-entries)
[230.421833] Starting subtest: read-all-entries
[230.516696] Subtest read-all-entries: SUCCESS (0.095s)
[230.581939] [077/155] (790s left) gem_ctx_engines (none)
[230.637249] Starting subtest: none
[230.639400] Subtest none: SUCCESS (0.001s)
[230.818644] [078/155] (790s left) i915_suspend (fence-restore-untiled)
[230.877113] Starting subtest: fence-restore-untiled
[230.881197] Subtest fence-restore-untiled: SKIP (0.000s)
[230.986357] [079/155] (790s left) kms_cursor_crc (cursor-onscreen-32x10)
[231.153222] Starting subtest: cursor-onscreen-32x10
[231.200723] Subtest cursor-onscreen-32x10: SKIP (0.047s)
[231.485188] [080/155] (790s left) kms_rotation_crc (primary-rotation-90)
[231.585208] Starting subtest: primary-rotation-90
[231.589745] Subtest primary-rotation-90: SKIP (0.001s)
[231.661106] [081/155] (789s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[231.742051] Starting subtest: fbc-psr2-primary-mmap-gtt
[231.744335] Starting dynamic subtest: eDP-1
[231.748631] Dynamic subtest eDP-1: SKIP (0.000s)
[231.752916] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[231.832117] [082/155] (789s left) gem_exec_reloc (basic-write-gtt-active)
[231.892940] Subtest basic-write-gtt-active: SKIP (0.000s)
[231.966626] [083/155] (789s left) kms_lease (page-flip-implicit-plane)
[232.054506] Starting subtest: page-flip-implicit-plane
[232.056570] Starting dynamic subtest: pipe-A-eDP-1
[232.521921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s)
[232.533690] Starting dynamic subtest: pipe-B-eDP-1
[233.667590] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[233.677200] Starting dynamic subtest: pipe-C-eDP-1
[234.770498] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[234.780211] Starting dynamic subtest: pipe-D-eDP-1
[235.906166] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[235.908469] Subtest page-flip-implicit-plane: SUCCESS (3.854s)
[236.751023] [084/155] (785s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[236.850701] Starting subtest: fbcpsrhdr-rgb565-draw-render
[236.854762] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[236.947550] [085/155] (784s left) kms_addfb_basic (legacy-format)
[237.003625] Starting subtest: legacy-format
[237.031073] Subtest legacy-format: SUCCESS (0.026s)
[237.177527] [086/155] (784s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[237.336057] Starting subtest: cursor-rapid-movement-32x10
[237.381049] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[237.689540] [087/155] (784s left) kms_force_connector_basic (force-connector-state)
[237.765543] Starting subtest: force-connector-state
[238.382772] Subtest force-connector-state: SUCCESS (0.617s)
[239.298694] [088/155] (782s left) kms_flip (flip-vs-dpms-on-nop)
[239.393456] Starting subtest: flip-vs-dpms-on-nop
[239.395649] Starting dynamic subtest: A-eDP1
[241.246333] Dynamic subtest A-eDP1: SUCCESS (1.854s)
[241.259251] Starting dynamic subtest: B-eDP1
[243.132671] Dynamic subtest B-eDP1: SUCCESS (1.885s)
[243.142872] Starting dynamic subtest: C-eDP1
[245.033536] Dynamic subtest C-eDP1: SUCCESS (1.900s)
[245.043248] Starting dynamic subtest: D-eDP1
[246.922708] Dynamic subtest D-eDP1: SUCCESS (1.887s)
[246.925064] Subtest flip-vs-dpms-on-nop: SUCCESS (7.534s)
[248.172240] [089/155] (773s left) syncobj_wait (wait-all-for-submit-complex)
[248.233580] Starting subtest: wait-all-for-submit-complex
[248.446822] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[248.523568] [090/155] (773s left) kms_fbcon_fbt (fbc)
[248.580595] Starting subtest: fbc
[255.022496] Subtest fbc: SUCCESS (6.440s)
[256.174162] [091/155] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[256.284360] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[256.288733] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[256.389815] [092/155] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[256.492659] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[256.497112] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[256.592515] [093/155] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[256.702768] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[263.080373] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.382s)
[263.218447] [094/155] (758s left) vgem_basic (sysfs)
[263.259293] Starting subtest: sysfs
[263.261440] Subtest sysfs: SUCCESS (0.000s)
[263.311565] [095/155] (758s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[263.398891] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[263.403282] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[263.503281] [096/155] (758s left) kms_cursor_edge_walk (128x128-left-edge)
[263.603995] Starting subtest: 128x128-left-edge
[263.606381] Starting dynamic subtest: pipe-A-eDP-1
[267.105371] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[267.116814] Starting dynamic subtest: pipe-D-eDP-1
[270.300616] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.192s)
[270.302978] Subtest 128x128-left-edge: SUCCESS (6.696s)
[271.175910] [097/155] (751s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[271.272171] Starting subtest: y-tiled-8bpp-rotate-270
[271.276594] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[271.359828] [098/155] (750s left) gem_flink_race (flink_close)
[271.390675] Starting subtest: flink_close
[276.485458] Subtest flink_close: SUCCESS (5.094s)
[276.564718] [099/155] (745s left) gem_exec_schedule (submit-early-slice)
[276.635050] Starting subtest: submit-early-slice
[276.637320] Starting dynamic subtest: rcs0
[276.703900] Dynamic subtest rcs0: SUCCESS (0.072s)
[276.713867] Starting dynamic subtest: bcs0
[276.766695] Dynamic subtest bcs0: SUCCESS (0.061s)
[276.776896] Starting dynamic subtest: vcs0
[276.829494] Dynamic subtest vcs0: SUCCESS (0.063s)
[276.840771] Starting dynamic subtest: vcs1
[276.900137] Dynamic subtest vcs1: SUCCESS (0.069s)
[276.910978] Starting dynamic subtest: vecs0
[276.964599] Dynamic subtest vecs0: SUCCESS (0.064s)
[276.976225] Starting dynamic subtest: ccs0
[277.028866] Dynamic subtest ccs0: SUCCESS (0.063s)
[277.031250] Subtest submit-early-slice: SUCCESS (0.399s)
[278.371807] [100/155] (744s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[278.474899] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[278.479244] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[278.570404] [101/155] (743s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[278.665157] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[278.669148] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[278.749396] [102/155] (743s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[278.813777] Starting subtest: multi-wait-all-for-submit-signaled
[278.816083] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[278.928857] [103/155] (743s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[279.022142] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[279.024471] Starting dynamic subtest: pipe-A-eDP-1
[279.047627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.059567] Starting dynamic subtest: pipe-B-eDP-1
[279.081131] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.089797] Starting dynamic subtest: pipe-C-eDP-1
[279.111242] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.119814] Starting dynamic subtest: pipe-D-eDP-1
[279.142177] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.146586] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[281.303676] [104/155] (741s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[281.412530] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[281.417036] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[281.525950] [105/155] (741s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[281.589278] Starting subtest: multi-wait-for-submit-unsubmitted
[281.694592] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[281.775111] [106/155] (740s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[281.868960] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[281.871171] Starting dynamic subtest: pipe-A-eDP-1
[287.628243] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.762s)
[287.638619] Starting dynamic subtest: pipe-B-eDP-1
[294.128137] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.499s)
[294.130412] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.263s)
[294.974440] [107/155] (727s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[295.072534] Starting subtest: multiplane-rotation-cropping-bottom
[312.542732] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.471s)
[312.658187] [108/155] (710s left) gem_ctx_persistence (engines-mixed)
[312.724559] Starting subtest: engines-mixed
[312.726349] Starting dynamic subtest: rcs0
[312.820891] Dynamic subtest rcs0: SUCCESS (0.095s)
[312.833595] Starting dynamic subtest: bcs0
[312.869368] Dynamic subtest bcs0: SUCCESS (0.046s)
[312.880758] Starting dynamic subtest: vcs0
[312.916269] Dynamic subtest vcs0: SUCCESS (0.045s)
[312.927909] Starting dynamic subtest: vcs1
[312.958078] Dynamic subtest vcs1: SUCCESS (0.039s)
[312.969837] Starting dynamic subtest: vecs0
[313.000109] Dynamic subtest vecs0: SUCCESS (0.040s)
[313.012631] Starting dynamic subtest: ccs0
[313.049190] Dynamic subtest ccs0: SUCCESS (0.047s)
[313.051540] Subtest engines-mixed: SUCCESS (0.326s)
[313.140455] [109/155] (709s left) gem_ctx_persistence (legacy-engines-cleanup)
[313.200455] Starting subtest: legacy-engines-cleanup
[313.202561] Starting dynamic subtest: render
[313.271439] Dynamic subtest render: SUCCESS (0.070s)
[313.285095] Starting dynamic subtest: bsd1
[313.319604] Dynamic subtest bsd1: SUCCESS (0.046s)
[313.331534] Starting dynamic subtest: bsd2
[313.369440] Dynamic subtest bsd2: SUCCESS (0.047s)
[313.381219] Starting dynamic subtest: blt
[313.419373] Dynamic subtest blt: SUCCESS (0.047s)
[313.431073] Starting dynamic subtest: vebox
[313.465087] Dynamic subtest vebox: SUCCESS (0.043s)
[313.467131] Subtest legacy-engines-cleanup: SUCCESS (0.266s)
[313.543694] [110/155] (709s left) perf_pmu (busy-idle)
[313.584804] Starting subtest: busy-idle
[313.586991] Starting dynamic subtest: rcs0
[314.276732] Dynamic subtest rcs0: SUCCESS (0.691s)
[314.288965] Starting dynamic subtest: bcs0
[314.949189] Dynamic subtest bcs0: SUCCESS (0.669s)
[314.961611] Starting dynamic subtest: vcs0
[316.291739] Dynamic subtest vcs0: SUCCESS (1.339s)
[316.305108] Starting dynamic subtest: vcs1
[318.274676] Dynamic subtest vcs1: SUCCESS (1.979s)
[318.288045] Starting dynamic subtest: vecs0
[320.323109] Dynamic subtest vecs0: SUCCESS (2.045s)
[320.334218] Starting dynamic subtest: ccs0
[320.993835] Dynamic subtest ccs0: SUCCESS (0.669s)
[320.996910] Subtest busy-idle: SUCCESS (7.410s)
[321.086611] [111/155] (701s left) gem_exec_balancer (hog)
[321.158386] Starting subtest: hog
[321.163084] Subtest hog: SKIP (0.000s)
[321.466821] [112/155] (701s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[321.567560] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[321.571940] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[321.676725] [113/155] (701s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[321.761343] Starting subtest: stress-xrgb8888-xtiled
[327.655347] Subtest stress-xrgb8888-xtiled: SUCCESS (5.894s)
[327.716235] [114/155] (695s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[327.808984] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[327.812550] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[327.893820] [115/155] (695s left) device_reset (cold-reset-bound)
[327.944207] Starting subtest: cold-reset-bound
[327.947847] Subtest cold-reset-bound: SKIP (0.000s)
[328.015029] [116/155] (695s left) gem_exercise_blt (fast-copy)
[328.067276] Starting subtest: fast-copy
[328.069189] Starting dynamic subtest: linear-smem-smem
[328.090566] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[328.100265] Starting dynamic subtest: xmajor-smem-smem
[328.109573] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[328.119062] Starting dynamic subtest: tile4-smem-smem
[328.128440] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[328.137562] Starting dynamic subtest: tile64-smem-smem
[328.147269] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[328.149219] Subtest fast-copy: SUCCESS (0.080s)
[328.290516] [117/155] (694s left) gem_busy (semaphore)
[328.490475] Subtest semaphore: SKIP (0.000s)
[328.726558] [118/155] (694s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[328.829304] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[328.833590] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[328.913210] [119/155] (694s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[329.013204] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[329.017339] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[329.104951] [120/155] (694s left) gem_exec_parallel (userptr)
[329.167187] Starting subtest: userptr
[329.169479] Starting dynamic subtest: rcs0
[330.621633] Dynamic subtest rcs0: SUCCESS (1.453s)
[330.633954] Starting dynamic subtest: bcs0
[332.094669] Dynamic subtest bcs0: SUCCESS (1.473s)
[332.105933] Starting dynamic subtest: vcs0
[334.275763] Dynamic subtest vcs0: SUCCESS (2.177s)
[334.287069] Starting dynamic subtest: vcs1
[336.322460] Dynamic subtest vcs1: SUCCESS (2.044s)
[336.335204] Starting dynamic subtest: vecs0
[338.306026] Dynamic subtest vecs0: SUCCESS (1.982s)
[338.316664] Starting dynamic subtest: ccs0
[339.795296] Dynamic subtest ccs0: SUCCESS (1.487s)
[339.797712] Subtest userptr: SUCCESS (10.628s)
[339.980983] [121/155] (683s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[340.083129] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[340.087672] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.185312] [122/155] (683s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[340.273648] Starting subtest: random-ccs-data-y-tiled-ccs
[340.275912] Starting dynamic subtest: pipe-A-eDP-1
[340.299948] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[340.314089] Starting dynamic subtest: pipe-B-eDP-1
[340.337381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[340.346856] Starting dynamic subtest: pipe-C-eDP-1
[340.370501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[340.379832] Starting dynamic subtest: pipe-D-eDP-1
[340.403573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[340.407940] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[342.470387] [123/155] (680s left) kms_content_protection (atomic-hdcp14)
[342.605409] Starting subtest: atomic-hdcp14
[342.610335] Subtest atomic-hdcp14: SKIP (0.000s)
[342.737607] [124/155] (680s left) gem_softpin (safe-alignment)
[342.796457] Starting subtest: safe-alignment
[342.819320] Subtest safe-alignment: SUCCESS (0.021s)
[344.361605] [125/155] (679s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[344.457246] Starting subtest: psr-2p-pri-indfb-multidraw
[344.461263] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[344.581283] [126/155] (678s left) prime_mmap (test_forked_cpu_write)
[344.623837] Starting subtest: test_forked_cpu_write
[344.626169] Starting dynamic subtest: test_forked_cpu_write-smem
[344.634063] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[344.636444] Subtest test_forked_cpu_write: SUCCESS (0.011s)
[344.753502] [127/155] (678s left) syncobj_timeline (device-submit-unordered)
[344.814760] Starting subtest: device-submit-unordered
[344.817155] Subtest device-submit-unordered: SUCCESS (0.001s)
[344.936310] [128/155] (678s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[345.033499] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[345.035718] Starting dynamic subtest: pipe-A-eDP-1
[345.130722] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[345.140996] Starting dynamic subtest: pipe-B-eDP-1
[346.314388] Dynamic subtest pipe-B-eDP-1: SKIP (1.181s)
[346.318690] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.282s)
[347.476067] [129/155] (676s left) kms_flip (2x-flip-vs-panning-interruptible)
[347.590871] Starting subtest: 2x-flip-vs-panning-interruptible
[347.602429] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[347.708120] [130/155] (675s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[347.798176] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[347.802436] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[347.903725] [131/155] (675s left) gem_exec_fence (submit-chain)
[348.082178] Starting subtest: submit-chain
[348.100391] Subtest submit-chain: SUCCESS (0.018s)
[350.349736] [132/155] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[350.454670] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[350.458791] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[350.546335] [133/155] (673s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[350.636383] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[350.638733] Starting dynamic subtest: pipe-A
[350.658290] Dynamic subtest pipe-A: SKIP (0.017s)
[350.668992] Starting dynamic subtest: pipe-B
[350.688844] Dynamic subtest pipe-B: SKIP (0.030s)
[350.699660] Starting dynamic subtest: pipe-C
[350.724113] Dynamic subtest pipe-C: SKIP (0.034s)
[350.734927] Starting dynamic subtest: pipe-D
[350.752414] Dynamic subtest pipe-D: SKIP (0.030s)
[350.756495] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.114s)
[350.863417] [134/155] (672s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[350.954287] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[350.958247] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[351.057376] [135/155] (672s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[351.154947] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[351.158959] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.237710] [136/155] (672s left) perf (missing-sample-flags)
[351.367631] Starting subtest: missing-sample-flags
[351.369516] Subtest missing-sample-flags: SUCCESS (0.000s)
[351.411592] [137/155] (672s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[351.500081] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[351.503714] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[351.586979] [138/155] (672s left) perf_pmu (init-sema)
[351.623337] Starting subtest: init-sema
[351.625412] Starting dynamic subtest: rcs0
[351.627502] Dynamic subtest rcs0: SUCCESS (0.003s)
[351.640992] Starting dynamic subtest: bcs0
[351.642651] Dynamic subtest bcs0: SUCCESS (0.000s)
[351.652017] Starting dynamic subtest: vcs0
[351.653640] Dynamic subtest vcs0: SUCCESS (0.000s)
[351.662771] Starting dynamic subtest: vcs1
[351.664379] Dynamic subtest vcs1: SUCCESS (0.001s)
[351.674634] Starting dynamic subtest: vecs0
[351.676558] Dynamic subtest vecs0: SUCCESS (0.001s)
[351.686205] Starting dynamic subtest: ccs0
[351.687767] Dynamic subtest ccs0: SUCCESS (0.000s)
[351.689496] Subtest init-sema: SUCCESS (0.009s)
[351.737126] [139/155] (672s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[351.789450] Starting subtest: invalid-single-wait-all-unsubmitted
[351.791382] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[351.920620] [140/155] (672s left) perf (i915-ref-count)
[351.983805] Starting subtest: i915-ref-count
[352.034438] Subtest i915-ref-count: SUCCESS (0.048s)
[352.094873] [141/155] (672s left) i915_getparams_basic (basic-eu-total)
[352.153061] Starting subtest: basic-eu-total
[352.156936] Subtest basic-eu-total: SUCCESS (0.000s)
[352.242122] [142/155] (671s left) gem_caching (read-writes)
[352.295643] Subtest read-writes: SKIP (0.000s)
[352.379383] [143/155] (671s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[352.483699] Starting subtest: fbchdr-rgb101010-draw-blt
[352.487362] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[352.588457] [144/155] (671s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[352.683978] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[352.687375] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[352.787782] [145/155] (671s left) prime_busy (hang)
[352.845160] Starting subtest: hang
[352.847137] Starting dynamic subtest: rcs0
[378.848672] Dynamic subtest rcs0: SUCCESS (25.998s)
[378.858471] Starting dynamic subtest: bcs0
[385.941099] Dynamic subtest bcs0: SUCCESS (7.091s)
[385.951295] Starting dynamic subtest: vcs0
[392.979435] Dynamic subtest vcs0: SUCCESS (7.037s)
[392.989654] Starting dynamic subtest: vcs1
[399.948537] Dynamic subtest vcs1: SUCCESS (6.969s)
[399.958601] Starting dynamic subtest: vecs0
[406.930291] Dynamic subtest vecs0: SUCCESS (6.981s)
[406.940211] Starting dynamic subtest: ccs0
[420.828648] Dynamic subtest ccs0: SUCCESS (13.897s)
[420.831079] Subtest hang: SUCCESS (67.979s)
[420.967671] [146/155] (603s left) gem_exec_whisper (basic-forked-all)
[421.028666] Starting subtest: basic-forked-all
[435.086803] Subtest basic-forked-all: SUCCESS (14.054s)
[435.287871] [147/155] (589s left) gem_exec_balancer (semaphore)
[435.345097] Starting subtest: semaphore
[437.304458] Subtest semaphore: SUCCESS (1.958s)
[437.642059] [148/155] (586s left) i915_drm_fdinfo (most-busy-check-all)
[437.684353] Starting subtest: most-busy-check-all
[437.686653] Starting dynamic subtest: rcs0
[437.691276] Dynamic subtest rcs0: SKIP (0.004s)
[437.703457] Starting dynamic subtest: bcs0
[437.707983] Dynamic subtest bcs0: SKIP (0.000s)
[437.717984] Starting dynamic subtest: vcs0
[437.722461] Dynamic subtest vcs0: SKIP (0.000s)
[437.732490] Starting dynamic subtest: vcs1
[437.736960] Dynamic subtest vcs1: SKIP (0.000s)
[437.746889] Starting dynamic subtest: vecs0
[437.750787] Dynamic subtest vecs0: SKIP (0.000s)
[437.760587] Starting dynamic subtest: ccs0
[437.764492] Dynamic subtest ccs0: SKIP (0.000s)
[437.768451] Subtest most-busy-check-all: SKIP (0.009s)
[437.806258] [149/155] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[437.930535] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[437.934938] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[438.025885] [150/155] (586s left) kms_invalid_mode (bad-htotal)
[438.127629] Starting subtest: bad-htotal
[438.130083] Starting dynamic subtest: pipe-A-eDP-1
[438.407476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[438.418843] Starting dynamic subtest: pipe-B-eDP-1
[438.421080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[438.432229] Starting dynamic subtest: pipe-C-eDP-1
[438.434056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[438.444368] Starting dynamic subtest: pipe-D-eDP-1
[438.446603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[438.448901] Subtest bad-htotal: SUCCESS (0.288s)
[439.267631] [151/155] (585s left) kms_getfb (getfb2-handle-not-fb)
[439.369259] Starting subtest: getfb2-handle-not-fb
[439.371633] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[439.500495] [152/155] (585s left) gem_exec_schedule (preempt-other-chain)
[439.580320] Starting subtest: preempt-other-chain
[439.582614] Starting dynamic subtest: rcs0
[439.661985] Dynamic subtest rcs0: SUCCESS (0.086s)
[439.678888] Starting dynamic subtest: bcs0
[439.743940] Dynamic subtest bcs0: SUCCESS (0.082s)
[439.759899] Starting dynamic subtest: vcs0
[439.826360] Dynamic subtest vcs0: SUCCESS (0.082s)
[439.837776] Starting dynamic subtest: vcs1
[439.904850] Dynamic subtest vcs1: SUCCESS (0.077s)
[439.925769] Starting dynamic subtest: vecs0
[439.985489] Dynamic subtest vecs0: SUCCESS (0.080s)
[439.997235] Starting dynamic subtest: ccs0
[440.064853] Dynamic subtest ccs0: SUCCESS (0.079s)
[440.067168] Subtest preempt-other-chain: SUCCESS (0.491s)
[441.385777] [153/155] (583s left) gem_workarounds (basic-read-context)
[441.446014] Starting subtest: basic-read-context
[441.459170] Subtest basic-read-context: SUCCESS (0.012s)
[441.599473] [154/155] (583s left) tools_test (sysfs_l3_parity)
[441.653369] Starting subtest: sysfs_l3_parity
[441.716061] Subtest sysfs_l3_parity: SKIP (0.075s)
[441.773814] [155/155] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[441.875827] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[441.880158] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[441.960916] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_param
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: api_intel_allocator
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_color_pipeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: prime_mmap_coherency
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_sync
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_render_copy_redux
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_rmfb
results: parsing output: 53/ for test: kms_selftest
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_vblank
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_ctx_shared
results: parsing output: 65/ for test: kms_plane_multiple
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_chamelium_frames
results: parsing output: 71/ for test: gem_pwrite_snooped
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gen7_exec_parse
results: parsing output: 75/ for test: core_debugfs
results: parsing output: 76/ for test: gem_ctx_engines
results: parsing output: 77/ for test: i915_suspend
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_force_connector_basic
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_fbcon_fbt
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: vgem_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_flink_race
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_pipe_stress
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: device_reset
results: parsing output: 115/ for test: gem_exercise_blt
results: parsing output: 116/ for test: gem_busy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_parallel
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: perf
results: parsing output: 136/ for test: kms_plane
results: parsing output: 137/ for test: perf_pmu
results: parsing output: 138/ for test: syncobj_wait
results: parsing output: 139/ for test: perf
results: parsing output: 140/ for test: i915_getparams_basic
results: parsing output: 141/ for test: gem_caching
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: prime_busy
results: parsing output: 145/ for test: gem_exec_whisper
results: parsing output: 146/ for test: gem_exec_balancer
results: parsing output: 147/ for test: i915_drm_fdinfo
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_invalid_mode
results: parsing output: 150/ for test: kms_getfb
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: gem_workarounds
results: parsing output: 153/ for test: tools_test
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.