[61.856566] Initializing watchdogs
[61.856615]   /dev/watchdog0
[61.870812] [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]
[61.875211] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.877799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.881407] [001/133] (960s left) kms_psr (fbc-psr2-cursor-blt)
[61.992939] Starting subtest: fbc-psr2-cursor-blt
[61.995211] Starting dynamic subtest: eDP-1
[61.999496] Dynamic subtest eDP-1: SKIP (0.000s)
[62.003563] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[62.074324] [002/133] (960s left) gem_exec_balancer (parallel-bb-first)
[62.338509] Starting subtest: parallel-bb-first
[63.329380] Subtest parallel-bb-first: SUCCESS (0.998s)
[63.929128] [003/133] (958s left) kms_cursor_edge_walk (128x128-top-edge)
[64.025288] Starting subtest: 128x128-top-edge
[64.027474] Starting dynamic subtest: pipe-A-eDP-1
[67.498085] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[67.510591] Starting dynamic subtest: pipe-D-eDP-1
[70.613236] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[70.615663] Subtest 128x128-top-edge: SUCCESS (6.608s)
[71.427205] [004/133] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[71.522700] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[71.526819] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[71.610369] [005/133] (950s left) gem_exec_parallel (contexts)
[71.691773] Starting subtest: contexts
[71.694154] Starting dynamic subtest: rcs0
[74.460671] Dynamic subtest rcs0: SUCCESS (2.771s)
[74.469281] Starting dynamic subtest: bcs0
[77.870659] Dynamic subtest bcs0: SUCCESS (3.412s)
[77.879293] Starting dynamic subtest: vcs0
[82.263339] Dynamic subtest vcs0: SUCCESS (4.392s)
[82.272031] Starting dynamic subtest: vcs1
[86.371577] Dynamic subtest vcs1: SUCCESS (4.108s)
[86.379286] Starting dynamic subtest: vecs0
[90.435380] Dynamic subtest vecs0: SUCCESS (4.063s)
[90.445331] Starting dynamic subtest: ccs0
[94.035643] Dynamic subtest ccs0: SUCCESS (3.599s)
[94.038649] Subtest contexts: SUCCESS (22.350s)
[94.225453] [006/133] (928s left) gem_exec_schedule (u-semaphore-resolve)
[94.301072] Starting subtest: u-semaphore-resolve
[94.361989] Subtest u-semaphore-resolve: SUCCESS (0.066s)
[94.690175] [007/133] (927s left) gem_exec_gttfill (engines)
[94.753055] Starting subtest: engines
[94.755408] Starting dynamic subtest: rcs0
[118.295997] Dynamic subtest rcs0: SUCCESS (23.542s)
[118.307567] Starting dynamic subtest: bcs0
[141.702260] Dynamic subtest bcs0: SUCCESS (23.404s)
[141.712923] Starting dynamic subtest: vcs0
[164.969354] Dynamic subtest vcs0: SUCCESS (23.265s)
[164.980681] Starting dynamic subtest: vcs1
[188.342246] Dynamic subtest vcs1: SUCCESS (23.371s)
[188.352288] Starting dynamic subtest: vecs0
[211.612542] Dynamic subtest vecs0: SUCCESS (23.269s)
[211.621562] Starting dynamic subtest: ccs0
[234.837059] Dynamic subtest ccs0: SUCCESS (23.223s)
[234.839789] Subtest engines: SUCCESS (140.080s)
[235.025451] [008/133] (787s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[235.181361] Starting subtest: yf-tiled-16bpp-rotate-0
[235.185389] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[235.261435] [009/133] (787s left) kms_big_fb (4-tiled-addfb)
[235.364713] Starting subtest: 4-tiled-addfb
[235.366727] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[235.470448] [010/133] (787s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[235.574593] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[235.576864] Starting dynamic subtest: pipe-A-eDP-1
[236.335579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s)
[236.345251] Starting dynamic subtest: pipe-B-eDP-1
[238.130757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s)
[238.144663] Starting dynamic subtest: pipe-C-eDP-1
[239.964941] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.832s)
[239.978450] Starting dynamic subtest: pipe-D-eDP-1
[241.791323] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.825s)
[241.793383] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.209s)
[242.929084] [011/133] (779s left) kms_content_protection (mei-interface)
[243.080334] Starting subtest: mei-interface
[243.091866] Subtest mei-interface: SKIP (0.010s)
[243.198978] [012/133] (779s left) i915_suspend (fence-restore-untiled)
[243.252742] Starting subtest: fence-restore-untiled
[243.257158] Subtest fence-restore-untiled: SKIP (0.000s)
[243.362060] [013/133] (779s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[243.456956] Starting subtest: fbc-psr-cursor-mmap-cpu
[243.458903] Starting dynamic subtest: eDP-1
[243.463125] Dynamic subtest eDP-1: SKIP (0.000s)
[243.467286] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[243.556936] [014/133] (779s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[243.671349] Starting subtest: flip-vs-cursor-crc-legacy
[244.365835] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.693s)
[245.190355] [015/133] (777s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[245.290363] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[245.294534] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[245.375842] [016/133] (777s left) gem_mmap_gtt (basic-small-bo-tiledy)
[245.437265] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[245.495104] [017/133] (777s left) kms_pm_rpm (basic-rte)
[245.539833] Starting subtest: basic-rte
[248.588230] Subtest basic-rte: SUCCESS (3.051s)
[250.406115] [018/133] (772s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[250.459569] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[250.462058] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[250.562114] [019/133] (772s left) i915_drm_fdinfo (virtual-busy-idle)
[250.600295] Starting subtest: virtual-busy-idle
[250.604671] Subtest virtual-busy-idle: SKIP (0.000s)
[250.662991] [020/133] (772s left) kms_psr (pr-primary-render)
[250.758091] Starting subtest: pr-primary-render
[250.762331] Subtest pr-primary-render: SKIP (0.000s)
[250.837396] [021/133] (772s left) gem_exec_big (single)
[250.905602] Starting subtest: single
[255.631603] Subtest single: SUCCESS (4.725s)
[255.890229] [022/133] (767s left) i915_drm_fdinfo (busy-idle-check-all)
[255.976319] Starting subtest: busy-idle-check-all
[255.978378] Starting dynamic subtest: rcs0
[255.986589] Dynamic subtest rcs0: SKIP (0.010s)
[255.996689] Starting dynamic subtest: bcs0
[256.000894] Dynamic subtest bcs0: SKIP (0.001s)
[256.009032] Starting dynamic subtest: vcs0
[256.013641] Dynamic subtest vcs0: SKIP (0.001s)
[256.021994] Starting dynamic subtest: vcs1
[256.026317] Dynamic subtest vcs1: SKIP (0.001s)
[256.034069] Starting dynamic subtest: vecs0
[256.038332] Dynamic subtest vecs0: SKIP (0.001s)
[256.046070] Starting dynamic subtest: ccs0
[256.050408] Dynamic subtest ccs0: SKIP (0.001s)
[256.054986] Subtest busy-idle-check-all: SKIP (0.020s)
[256.090296] [023/133] (767s left) kms_async_flips (crc)
[256.218054] Starting subtest: crc
[256.603529] Starting dynamic subtest: pipe-A-eDP-1
[259.523238] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.920s)
[259.898718] Starting dynamic subtest: pipe-B-eDP-1
[262.855062] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.963s)
[263.234675] Starting dynamic subtest: pipe-C-eDP-1
[266.158507] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.933s)
[266.522767] Starting dynamic subtest: pipe-D-eDP-1
[269.380865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[269.383224] Subtest crc: SUCCESS (13.164s)
[270.562422] [024/133] (752s left) gem_userptr_blits (coherency-unsync)
[270.641969] Subtest coherency-unsync: SKIP (0.000s)
[270.757625] [025/133] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[270.853240] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[270.857159] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[270.946792] [026/133] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[271.040461] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[275.312200] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.274s)
[276.472985] [027/133] (746s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[276.571242] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[276.575564] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[276.648813] [028/133] (746s left) kms_feature_discovery (psr2)
[276.748707] Starting subtest: psr2
[276.751044] Subtest psr2: SUCCESS (0.000s)
[276.820174] [029/133] (746s left) kms_pm_rpm (pm-tiling)
[279.079759] Starting subtest: pm-tiling
[279.084763] Subtest pm-tiling: SKIP (0.000s)
[279.443042] [030/133] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[279.542242] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[279.546638] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[279.637976] [031/133] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[279.758547] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[286.321996] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.564s)
[286.431743] [032/133] (737s left) kms_color (invalid-gamma-lut-sizes)
[286.533333] Starting subtest: invalid-gamma-lut-sizes
[286.535576] Starting dynamic subtest: pipe-A
[286.828843] Dynamic subtest pipe-A: SUCCESS (0.295s)
[286.838947] Starting dynamic subtest: pipe-B
[286.841294] Dynamic subtest pipe-B: SUCCESS (0.000s)
[286.851212] Starting dynamic subtest: pipe-C
[286.853405] Dynamic subtest pipe-C: SUCCESS (0.000s)
[286.862192] Starting dynamic subtest: pipe-D
[286.864428] Dynamic subtest pipe-D: SUCCESS (0.000s)
[286.866807] Subtest invalid-gamma-lut-sizes: SUCCESS (0.297s)
[287.635884] [033/133] (736s left) kms_dsc (dsc-basic)
[287.733244] Starting subtest: dsc-basic
[287.746949] Subtest dsc-basic: SKIP (0.000s)
[287.806068] [034/133] (735s left) gem_ctx_persistence (legacy-engines-persistence)
[287.870443] Starting subtest: legacy-engines-persistence
[287.872441] Starting dynamic subtest: render
[288.662703] Dynamic subtest render: SUCCESS (0.793s)
[288.672877] Starting dynamic subtest: bsd1
[289.409887] Dynamic subtest bsd1: SUCCESS (0.746s)
[289.420572] Starting dynamic subtest: bsd2
[290.200179] Dynamic subtest bsd2: SUCCESS (0.788s)
[290.211450] Starting dynamic subtest: blt
[290.973299] Dynamic subtest blt: SUCCESS (0.771s)
[290.985035] Starting dynamic subtest: vebox
[291.708204] Dynamic subtest vebox: SUCCESS (0.733s)
[291.710749] Subtest legacy-engines-persistence: SUCCESS (3.840s)
[291.827228] [035/133] (731s left) gem_ctx_param (invalid-get-ringsize)
[291.880920] Starting subtest: invalid-get-ringsize
[291.883412] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[291.978703] [036/133] (731s left) kms_psr (psr2-primary-mmap-cpu)
[292.069791] Starting subtest: psr2-primary-mmap-cpu
[292.072070] Starting dynamic subtest: eDP-1
[293.811938] Dynamic subtest eDP-1: SUCCESS (1.741s)
[293.814181] Subtest psr2-primary-mmap-cpu: SUCCESS (1.742s)
[294.693793] [037/133] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[294.795092] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[294.799075] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[294.861275] [038/133] (728s left) gem_userptr_blits (unsync-overlap)
[294.924050] Subtest unsync-overlap: SKIP (0.000s)
[295.036488] [039/133] (728s left) kms_dirtyfb (default-dirtyfb-ioctl)
[295.133035] Starting subtest: default-dirtyfb-ioctl
[295.135295] Starting dynamic subtest: A-eDP-1
[296.742873] Dynamic subtest A-eDP-1: SUCCESS (1.608s)
[296.744851] Subtest default-dirtyfb-ioctl: SUCCESS (1.609s)
[297.618771] [040/133] (726s left) sysfs_heartbeat_interval (idempotent)
[297.678604] Starting subtest: idempotent
[297.681051] Starting dynamic subtest: vecs0
[297.683462] Dynamic subtest vecs0: SUCCESS (0.001s)
[297.693290] Starting dynamic subtest: ccs0
[297.695653] Dynamic subtest ccs0: SUCCESS (0.001s)
[297.703819] Starting dynamic subtest: vcs0
[297.706095] Dynamic subtest vcs0: SUCCESS (0.000s)
[297.714036] Starting dynamic subtest: bcs0
[297.716321] Dynamic subtest bcs0: SUCCESS (0.001s)
[297.724436] Starting dynamic subtest: rcs0
[297.726684] Dynamic subtest rcs0: SUCCESS (0.000s)
[297.734560] Starting dynamic subtest: vcs1
[297.736851] Dynamic subtest vcs1: SUCCESS (0.000s)
[297.739210] Subtest idempotent: SUCCESS (0.007s)
[297.793313] [041/133] (726s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[297.905655] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[299.006499] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.102s)
[299.138830] [042/133] (724s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[299.203053] Starting subtest: single-wait-all-for-submit-signaled
[299.205062] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[299.315825] [043/133] (724s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[299.408455] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[299.411870] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[299.485997] [044/133] (724s left) kms_async_flips (invalid-async-flip-atomic)
[299.566064] Starting subtest: invalid-async-flip-atomic
[299.942505] Starting dynamic subtest: pipe-A-eDP-1
[300.744641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s)
[301.109225] Starting dynamic subtest: pipe-B-eDP-1
[301.880151] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[302.253929] Starting dynamic subtest: pipe-C-eDP-1
[303.020844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[303.374767] Starting dynamic subtest: pipe-D-eDP-1
[304.148853] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[304.151271] Subtest invalid-async-flip-atomic: SUCCESS (4.584s)
[305.289855] [045/133] (718s left) gem_softpin (evict-prime-sanity-check)
[305.358152] Starting subtest: evict-prime-sanity-check
[305.360586] Starting dynamic subtest: rcs0
[306.506235] Dynamic subtest rcs0: SUCCESS (1.148s)
[306.517848] Starting dynamic subtest: bcs0
[307.627661] Dynamic subtest bcs0: SUCCESS (1.121s)
[307.637168] Starting dynamic subtest: vcs0
[308.859753] Dynamic subtest vcs0: SUCCESS (1.228s)
[308.870975] Starting dynamic subtest: vcs1
[310.862898] Dynamic subtest vcs1: SUCCESS (2.001s)
[310.878281] Starting dynamic subtest: vecs0
[312.846821] Dynamic subtest vecs0: SUCCESS (1.982s)
[312.858066] Starting dynamic subtest: ccs0
[313.973902] Dynamic subtest ccs0: SUCCESS (1.127s)
[313.983460] Starting dynamic subtest: all
[315.086631] Dynamic subtest all: SUCCESS (1.112s)
[315.089097] Subtest evict-prime-sanity-check: SUCCESS (9.729s)
[315.163315] [046/133] (708s left) gem_ctx_param (basic-default)
[315.209714] Starting subtest: basic-default
[315.212070] Subtest basic-default: SUCCESS (0.000s)
[315.293432] [047/133] (708s left) kms_pipe_crc_basic (nonblocking-crc)
[315.383623] Starting subtest: nonblocking-crc
[315.385941] Starting dynamic subtest: pipe-A-eDP-1
[316.163864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[316.173226] Starting dynamic subtest: pipe-B-eDP-1
[317.638450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[317.651776] Starting dynamic subtest: pipe-C-eDP-1
[318.994750] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[319.003683] Starting dynamic subtest: pipe-D-eDP-1
[320.307599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[320.309535] Subtest nonblocking-crc: SUCCESS (4.922s)
[321.109812] [048/133] (703s left) kms_flip (2x-absolute-wf_vblank)
[321.216248] Starting subtest: 2x-absolute-wf_vblank
[321.225494] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[321.314419] [049/133] (702s left) perf_pmu (invalid-init)
[321.360445] Starting subtest: invalid-init
[321.362809] Subtest invalid-init: SUCCESS (0.000s)
[321.448666] [050/133] (702s left) kms_addfb_basic (invalid-get-prop)
[321.507386] Starting subtest: invalid-get-prop
[321.509644] Subtest invalid-get-prop: SUCCESS (0.000s)
[321.636642] [051/133] (702s left) gem_exec_schedule (pi-shared-iova)
[321.834570] Starting subtest: pi-shared-iova
[321.836635] Starting dynamic subtest: rcs0
[321.934362] Dynamic subtest rcs0: SUCCESS (0.100s)
[321.945407] Starting dynamic subtest: vcs0
[321.998555] Dynamic subtest vcs0: SUCCESS (0.063s)
[322.009024] Starting dynamic subtest: vcs1
[322.051309] Dynamic subtest vcs1: SUCCESS (0.052s)
[322.064821] Starting dynamic subtest: vecs0
[322.102967] Dynamic subtest vecs0: SUCCESS (0.051s)
[322.112770] Starting dynamic subtest: ccs0
[322.166986] Dynamic subtest ccs0: SUCCESS (0.063s)
[322.169676] Subtest pi-shared-iova: SUCCESS (0.334s)
[324.006433] [052/133] (700s left) prime_mmap (test_forked)
[324.059803] Starting subtest: test_forked
[324.061778] Starting dynamic subtest: test_forked-smem
[324.100423] Dynamic subtest test_forked-smem: SUCCESS (0.042s)
[324.102773] Subtest test_forked: SUCCESS (0.044s)
[324.218431] [053/133] (700s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[324.313095] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[324.315391] Starting dynamic subtest: pipe-A
[324.648608] Dynamic subtest pipe-A: SUCCESS (0.338s)
[324.657877] Starting dynamic subtest: pipe-B
[326.015452] Dynamic subtest pipe-B: SUCCESS (1.365s)
[326.024925] Starting dynamic subtest: pipe-C
[327.453066] Dynamic subtest pipe-C: SUCCESS (1.437s)
[327.461583] Starting dynamic subtest: pipe-D
[328.871161] Dynamic subtest pipe-D: SUCCESS (1.417s)
[328.873421] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.562s)
[330.049463] [054/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[330.145197] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[330.149139] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[330.240616] [055/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[330.335352] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[330.339596] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[330.413777] [056/133] (694s left) gem_wait (wait)
[330.481302] Starting subtest: wait
[330.483476] Starting dynamic subtest: all-engines
[331.924582] Dynamic subtest all-engines: SUCCESS (1.444s)
[331.936045] Starting dynamic subtest: rcs0
[332.971417] Dynamic subtest rcs0: SUCCESS (1.046s)
[332.982418] Starting dynamic subtest: bcs0
[334.024746] Dynamic subtest bcs0: SUCCESS (1.050s)
[334.035957] Starting dynamic subtest: vcs0
[335.069534] Dynamic subtest vcs0: SUCCESS (1.043s)
[335.081005] Starting dynamic subtest: vcs1
[336.114852] Dynamic subtest vcs1: SUCCESS (1.043s)
[336.126058] Starting dynamic subtest: vecs0
[337.165475] Dynamic subtest vecs0: SUCCESS (1.049s)
[337.176764] Starting dynamic subtest: ccs0
[338.211335] Dynamic subtest ccs0: SUCCESS (1.044s)
[338.213883] Subtest wait: SUCCESS (7.733s)
[338.407024] [057/133] (686s left) perf (mi-rpc)
[338.536639] Starting subtest: mi-rpc
[338.541174] Subtest mi-rpc: SKIP (0.000s)
[338.576447] [058/133] (686s left) kms_flip (2x-flip-vs-dpms)
[338.665801] Starting subtest: 2x-flip-vs-dpms
[338.674814] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[338.761334] [059/133] (685s left) syncobj_basic (bad-create-flags)
[338.820510] Starting subtest: bad-create-flags
[338.822701] Subtest bad-create-flags: SUCCESS (0.000s)
[338.923332] [060/133] (685s left) api_intel_allocator (gem-pool)
[338.980464] Starting subtest: gem-pool
[338.987078] Subtest gem-pool: SUCCESS (0.009s)
[339.096821] [061/133] (685s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[339.177257] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[339.181788] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[339.250577] [062/133] (685s left) gem_exec_whisper (basic-sync)
[339.314349] Starting subtest: basic-sync
[345.978440] Subtest basic-sync: SUCCESS (6.664s)
[346.160569] [063/133] (678s left) perf_pmu (busy-start)
[346.208491] Starting subtest: busy-start
[346.210751] Starting dynamic subtest: rcs0
[348.761073] Dynamic subtest rcs0: SUCCESS (2.552s)
[348.772896] Starting dynamic subtest: bcs0
[351.311019] Dynamic subtest bcs0: SUCCESS (2.547s)
[351.322764] Starting dynamic subtest: vcs0
[354.900537] Dynamic subtest vcs0: SUCCESS (3.586s)
[354.912048] Starting dynamic subtest: vcs1
[358.932507] Dynamic subtest vcs1: SUCCESS (4.029s)
[358.942788] Starting dynamic subtest: vecs0
[362.900400] Dynamic subtest vecs0: SUCCESS (3.965s)
[362.911647] Starting dynamic subtest: ccs0
[365.451513] Dynamic subtest ccs0: SUCCESS (2.549s)
[365.454217] Subtest busy-start: SUCCESS (19.244s)
[365.539256] [064/133] (659s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[365.642210] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[365.644493] Starting dynamic subtest: pipe-A-eDP-1
[365.701921] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[365.710051] Starting dynamic subtest: pipe-B-eDP-1
[365.767300] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[365.777298] Starting dynamic subtest: pipe-C-eDP-1
[365.834808] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[365.844652] Starting dynamic subtest: pipe-D-eDP-1
[365.903346] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[365.907548] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[367.909583] [065/133] (656s left) kms_lease (lease-unleased-crtc)
[368.001854] Starting subtest: lease-unleased-crtc
[368.004180] Starting dynamic subtest: pipe-A-eDP-1
[368.289556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[368.303067] Starting dynamic subtest: pipe-B-eDP-1
[369.062270] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[369.073374] Starting dynamic subtest: pipe-C-eDP-1
[369.075635] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[369.084296] Starting dynamic subtest: pipe-D-eDP-1
[369.086451] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[369.088596] Subtest lease-unleased-crtc: SUCCESS (1.073s)
[369.427359] [066/133] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[369.530031] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[369.534120] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[369.622551] [067/133] (655s left) prime_vgem (basic-fence-read)
[369.776820] Starting subtest: basic-fence-read
[369.785488] Subtest basic-fence-read: SKIP (0.006s)
[369.901659] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[369.906496] [068/133] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[369.997451] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[370.001591] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[370.105030] [069/133] (654s left) gem_exec_params (dr4-dirt)
[370.152459] Starting subtest: DR4-dirt
[370.154749] Subtest DR4-dirt: SUCCESS (0.000s)
[370.247370] [070/133] (654s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[370.350480] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[378.024660] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.676s)
[378.138731] [071/133] (646s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[378.239592] Starting subtest: fbc-modesetfrombusy
[382.127409] Subtest fbc-modesetfrombusy: SUCCESS (3.893s)
[383.353909] [072/133] (641s left) gem_create (create-ext-placement-sanity-check)
[383.534050] Starting subtest: create-ext-placement-sanity-check
[383.536697] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[383.637380] [073/133] (641s left) gem_partial_pwrite_pread (reads-uncached)
[383.704615] Subtest reads-uncached: SKIP (0.000s)
[383.772428] [074/133] (641s left) gem_reg_read (timestamp-monotonic)
[383.824308] Starting subtest: timestamp-monotonic
[388.720403] Subtest timestamp-monotonic: SUCCESS (4.896s)
[388.795462] [075/133] (636s left) kms_invalid_mode (int-max-clock)
[388.900180] Starting subtest: int-max-clock
[388.902386] Starting dynamic subtest: pipe-A-eDP-1
[389.180950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[389.190928] Starting dynamic subtest: pipe-B-eDP-1
[389.193234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[389.201816] Starting dynamic subtest: pipe-C-eDP-1
[389.204143] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[389.212657] Starting dynamic subtest: pipe-D-eDP-1
[389.215044] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[389.217444] Subtest int-max-clock: SUCCESS (0.290s)
[390.043710] [076/133] (635s left) gen7_exec_parse (oacontrol-tracking)
[390.109410] Subtest oacontrol-tracking: SKIP (0.000s)
[390.187495] [077/133] (635s left) gem_flink_basic (bad-flink)
[390.242721] Starting subtest: bad-flink
[390.245056] Subtest bad-flink: SUCCESS (0.000s)
[390.333701] [078/133] (635s left) kms_chamelium_edid (dp-edid-resolution-list)
[390.728213] Subtest dp-edid-resolution-list: SKIP (0.000s)
[391.545260] [079/133] (633s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[391.642495] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[391.644837] Starting dynamic subtest: pipe-A-eDP-1
[391.668870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[391.682269] Starting dynamic subtest: pipe-B-eDP-1
[391.704398] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[391.713401] Starting dynamic subtest: pipe-C-eDP-1
[391.735540] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[391.745746] Starting dynamic subtest: pipe-D-eDP-1
[391.767823] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[391.771911] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[393.939051] [080/133] (631s left) gen3_render_linear_blits
[394.069799] [081/133] (631s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[394.129825] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[394.193081] [082/133] (631s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[394.308020] Starting subtest: 2x-long-flip-vs-cursor-legacy
[394.312251] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[394.455817] [083/133] (631s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[394.519148] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[394.523634] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[394.701482] [084/133] (630s left) kms_busy (extended-modeset-hang-oldfb)
[394.802314] Starting subtest: extended-modeset-hang-oldfb
[394.804340] Starting dynamic subtest: pipe-A
[406.520388] Dynamic subtest pipe-A: SUCCESS (11.717s)
[406.529872] Starting dynamic subtest: pipe-D
[419.270419] Dynamic subtest pipe-D: SUCCESS (12.744s)
[419.272650] Subtest extended-modeset-hang-oldfb: SUCCESS (24.467s)
[420.152702] [085/133] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[420.265324] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[426.865491] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.602s)
[426.993075] [086/133] (598s left) perf_pmu (busy-check-all)
[427.038735] Starting subtest: busy-check-all
[427.041119] Starting dynamic subtest: rcs0
[427.598603] Dynamic subtest rcs0: SUCCESS (0.561s)
[427.611037] Starting dynamic subtest: bcs0
[428.149560] Dynamic subtest bcs0: SUCCESS (0.549s)
[428.161327] Starting dynamic subtest: vcs0
[429.909245] Dynamic subtest vcs0: SUCCESS (1.755s)
[429.921429] Starting dynamic subtest: vcs1
[431.892539] Dynamic subtest vcs1: SUCCESS (1.981s)
[431.904234] Starting dynamic subtest: vecs0
[433.941382] Dynamic subtest vecs0: SUCCESS (2.046s)
[433.952865] Starting dynamic subtest: ccs0
[434.495283] Dynamic subtest ccs0: SUCCESS (0.553s)
[434.498044] Subtest busy-check-all: SUCCESS (7.459s)
[434.599951] [087/133] (591s left) gem_exec_whisper (basic-fds-all)
[434.667723] Starting subtest: basic-fds-all
[447.862067] Subtest basic-fds-all: SUCCESS (13.189s)
[448.047952] [088/133] (577s left) kms_addfb_basic (unused-pitches)
[448.105029] Starting subtest: unused-pitches
[448.107313] Subtest unused-pitches: SUCCESS (0.000s)
[448.249714] [089/133] (577s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[448.351072] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[448.353381] Starting dynamic subtest: pipe-A-eDP-1
[448.375462] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.390672] Starting dynamic subtest: pipe-B-eDP-1
[448.412174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.420940] Starting dynamic subtest: pipe-C-eDP-1
[448.442250] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.450937] Starting dynamic subtest: pipe-D-eDP-1
[448.472621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.476959] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[450.661107] [090/133] (575s left) kms_psr (psr-primary-mmap-gtt)
[450.760299] Starting subtest: psr-primary-mmap-gtt
[450.762520] Starting dynamic subtest: eDP-1
[452.160897] Dynamic subtest eDP-1: SKIP (1.398s)
[452.165626] Subtest psr-primary-mmap-gtt: SKIP (1.400s)
[452.299795] [091/133] (573s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[452.397594] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[452.399908] Starting dynamic subtest: pipe-A-eDP-1
[452.409064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[452.418344] Starting dynamic subtest: pipe-B-eDP-1
[452.427533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[452.436835] Starting dynamic subtest: pipe-C-eDP-1
[452.446054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[452.454432] Starting dynamic subtest: pipe-D-eDP-1
[452.463070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.467202] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[454.667846] [092/133] (571s left) kms_flip (2x-nonexisting-fb)
[454.755422] Starting subtest: 2x-nonexisting-fb
[454.763891] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[454.845432] [093/133] (571s left) fbdev (nullptr)
[454.892645] Starting subtest: nullptr
[454.894823] Subtest nullptr: SUCCESS (0.000s)
[454.954450] [094/133] (571s left) vgem_basic (unload)
[454.992889] Starting subtest: unload
[484.071159] Subtest unload: SUCCESS (29.076s)
[484.236686] [095/133] (541s left) gem_lmem_swapping (smem-oom)
[484.290184] Subtest smem-oom: SKIP (0.000s)
[484.343132] [096/133] (541s left) dmabuf_sync_file (export-wait-after-attach)
[484.389763] Starting subtest: export-wait-after-attach
[484.392052] Subtest export-wait-after-attach: SUCCESS (0.001s)
[484.447876] [097/133] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[484.537067] Starting subtest: psr-2p-primscrn-cur-indfb-move
[484.541165] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[484.645452] [098/133] (541s left) perf (invalid-create-userspace-config)
[484.753628] Starting subtest: invalid-create-userspace-config
[484.756071] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[484.805624] [099/133] (541s left) gem_ctx_sseu (invalid-args)
[484.878900] Subtest invalid-args: SKIP (0.000s)
[484.951894] [100/133] (541s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[485.051914] Starting subtest: yf-tiled-8bpp-rotate-270
[485.056307] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[485.145939] [101/133] (541s left) syncobj_timeline (32bits-limit)
[485.215047] Starting subtest: 32bits-limit
[485.217129] Subtest 32bits-limit: SUCCESS (0.001s)
[485.312931] [102/133] (541s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[485.410333] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[485.413938] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[485.483385] [103/133] (541s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[485.541964] Starting subtest: etime-single-wait-all-for-submit-submitted
[485.648857] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[485.740365] [104/133] (540s left) gem_userptr_blits (unsync-unmap-cycles)
[485.807633] Subtest unsync-unmap-cycles: SKIP (0.000s)
[485.922336] [105/133] (540s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[485.977835] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[485.980119] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[486.071320] [106/133] (540s left) gem_mmap_gtt (big-bo-tiledx)
[486.125159] Subtest big-bo-tiledX: SKIP (0.000s)
[486.197295] [107/133] (540s left) sw_sync (sync_merge_invalid)
[486.234252] Starting subtest: sync_merge_invalid
[486.256590] Subtest sync_merge_invalid: SUCCESS (0.025s)
[486.331508] [108/133] (540s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[486.426566] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[486.430886] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[486.533902] [109/133] (540s left) i915_pm_rc6_residency (rc6-accuracy)
[486.587891] Starting subtest: rc6-accuracy
[486.589989] Starting dynamic subtest: gt0
[489.760589] Dynamic subtest gt0: SUCCESS (3.169s)
[489.770908] Starting dynamic subtest: gt1
[492.931694] Dynamic subtest gt1: SUCCESS (3.168s)
[492.934241] Subtest rc6-accuracy: SUCCESS (6.343s)
[493.010911] [110/133] (533s left) perf (polling)
[493.123904] Starting subtest: polling
[493.126250] Starting dynamic subtest: 0-rcs0
[503.164139] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[503.173355] Starting dynamic subtest: 1-vcs0
[513.185859] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[513.188395] Subtest polling: SUCCESS (20.061s)
[513.234800] [111/133] (513s left) kms_cursor_crc (cursor-alpha-transparent)
[513.334801] Starting subtest: cursor-alpha-transparent
[513.337057] Starting dynamic subtest: pipe-A-eDP-1
[513.956390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[513.967432] Starting dynamic subtest: pipe-D-eDP-1
[515.268320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[515.270159] Subtest cursor-alpha-transparent: SUCCESS (1.933s)
[516.134239] [112/133] (510s left) gem_render_copy (linear-to-vebox-y-tiled)
[516.187616] Starting subtest: linear-to-vebox-y-tiled
[516.192109] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[516.372516] [113/133] (510s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[516.466545] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[516.470720] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[516.566420] [114/133] (510s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[516.719828] Starting subtest: cursor-rapid-movement-32x10
[516.770337] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[517.048925] [115/133] (509s left) api_intel_bb (simple-bb)
[517.095506] Starting subtest: simple-bb
[517.097941] Subtest simple-bb: SUCCESS (0.005s)
[517.220208] [116/133] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[517.316438] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[524.089710] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.774s)
[524.220582] [117/133] (502s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[524.327261] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[524.376616] [118/133] (502s left) gem_mmap_offset (oob-read)
[524.426358] Starting subtest: oob-read
[524.428269] Subtest oob-read: SUCCESS (0.000s)
[524.521941] [119/133] (502s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[524.629558] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[525.664209] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.035s)
[525.811461] [120/133] (501s left) prime_busy (hang-wait)
[525.883106] Starting subtest: hang-wait
[525.885069] Starting dynamic subtest: rcs0
[552.434868] Dynamic subtest rcs0: SUCCESS (26.545s)
[552.445744] Starting dynamic subtest: bcs0
[559.525094] Dynamic subtest bcs0: SUCCESS (7.091s)
[559.533947] Starting dynamic subtest: vcs0
[566.564567] Dynamic subtest vcs0: SUCCESS (7.035s)
[566.574676] Starting dynamic subtest: vcs1
[573.541803] Dynamic subtest vcs1: SUCCESS (6.974s)
[573.551463] Starting dynamic subtest: vecs0
[580.515787] Dynamic subtest vecs0: SUCCESS (6.972s)
[580.525649] Starting dynamic subtest: ccs0
[594.415089] Dynamic subtest ccs0: SUCCESS (13.896s)
[594.417579] Subtest hang-wait: SUCCESS (68.527s)
[594.545267] [121/133] (432s left) gem_tiled_fence_blits (basic)
[594.605372] Subtest basic: SKIP (0.000s)
[594.682381] [122/133] (432s left) gem_exec_fence (syncobj-timeline-export)
[595.242227] Starting subtest: syncobj-timeline-export
[595.252052] Subtest syncobj-timeline-export: SUCCESS (0.012s)
[596.945223] [123/133] (430s left) gem_fence_thrash (bo-write-verify-none)
[596.985162] Starting subtest: bo-write-verify-none
[597.000050] Subtest bo-write-verify-none: SKIP (0.012s)
[597.068842] [124/133] (430s left) gem_tiled_blits (normal)
[597.123486] Subtest normal: SKIP (0.000s)
[597.189554] [125/133] (430s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[597.290177] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[597.294131] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[597.383308] [126/133] (430s left) kms_chamelium_hpd (hdmi-hpd)
[597.770779] Subtest hdmi-hpd: SKIP (0.000s)
[598.585980] [127/133] (428s left) kms_vblank (query-forked-busy-hang)
[598.692443] Starting subtest: query-forked-busy-hang
[598.694625] Starting dynamic subtest: pipe-A-eDP-1
[624.724240] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.031s)
[624.743356] Starting dynamic subtest: pipe-D-eDP-1
[639.638960] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.910s)
[639.641433] Subtest query-forked-busy-hang: SUCCESS (40.947s)
[640.485611] [128/133] (387s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[640.555354] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[640.557632] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[640.647693] [129/133] (387s left) gem_mmap (pf-nonblock)
[640.703591] Subtest pf-nonblock: SKIP (0.000s)
[640.760549] [130/133] (386s left) kms_flip (blocking-absolute-wf_vblank)
[640.853122] Starting subtest: blocking-absolute-wf_vblank
[640.855448] Starting dynamic subtest: A-eDP1
[649.620716] Dynamic subtest A-eDP1: SUCCESS (8.766s)
[649.639504] Starting dynamic subtest: B-eDP1
[658.353741] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[658.366275] Starting dynamic subtest: C-eDP1
[667.077415] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[667.095977] Starting dynamic subtest: D-eDP1
[675.810570] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[675.816254] Subtest blocking-absolute-wf_vblank: SUCCESS (34.963s)
[677.026865] [131/133] (350s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[677.123639] Starting subtest: psr2-cursor-plane-update-sf
[677.125808] Starting dynamic subtest: pipe-A-eDP-1
[677.705501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.582s)
[677.724421] Starting dynamic subtest: pipe-B-eDP-1
[679.014789] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s)
[679.017086] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.895s)
[679.889300] [132/133] (347s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[679.994990] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[679.999193] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[680.097740] [133/133] (347s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[680.180304] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[680.182593] Starting dynamic subtest: pipe-A
[680.304284] Dynamic subtest pipe-A: SKIP (0.119s)
[680.314305] Starting dynamic subtest: pipe-B
[681.452382] Dynamic subtest pipe-B: SKIP (1.148s)
[681.467884] Starting dynamic subtest: pipe-C
[682.594128] Dynamic subtest pipe-C: SUCCESS (1.148s)
[682.603563] Starting dynamic subtest: pipe-D
[683.738102] Dynamic subtest pipe-D: SUCCESS (1.143s)
[683.740482] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.561s)
[684.939192] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_exec_parallel
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_exec_gttfill
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_content_protection
results: parsing output: 11/ for test: i915_suspend
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_big
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_dsc
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: sysfs_heartbeat_interval
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_pipe_crc_basic
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_wait
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: gem_partial_pwrite_pread
results: parsing output: 73/ for test: gem_reg_read
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: gem_flink_basic
results: parsing output: 77/ for test: kms_chamelium_edid
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gen3_render_linear_blits
results: parsing output: 80/ for test: kms_pipe_b_c_ivb
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: vgem_basic
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: dmabuf_sync_file
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gem_ctx_sseu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_rc6_residency
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_tiled_display
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: gem_tiled_fence_blits
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: gem_tiled_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.