[57.774646] Initializing watchdogs
[57.774792]   /dev/watchdog0
[57.792208] [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.796798] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.799529] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.802762] [001/155] (960s left) kms_psr (fbc-pr-dpms)
[57.921940] Starting subtest: fbc-pr-dpms
[57.926600] Subtest fbc-pr-dpms: SKIP (0.000s)
[58.004858] [002/155] (960s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[58.111876] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[58.114263] Starting dynamic subtest: pipe-A-eDP-1
[58.173877] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[58.181367] Starting dynamic subtest: pipe-B-eDP-1
[58.240409] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[58.249292] Starting dynamic subtest: pipe-C-eDP-1
[58.306725] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[58.315532] Starting dynamic subtest: pipe-D-eDP-1
[58.374141] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[58.378571] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[60.646267] [003/155] (957s left) gem_ctx_bad_destroy (invalid-pad)
[60.707909] Starting subtest: invalid-pad
[60.710427] Subtest invalid-pad: SUCCESS (0.000s)
[60.795009] [004/155] (957s left) gen3_render_tiledx_blits
[60.921252] [005/155] (957s left) kms_content_protection (atomic-dpms)
[61.069857] Starting subtest: atomic-dpms
[61.074839] Subtest atomic-dpms: SKIP (0.000s)
[61.172928] [006/155] (957s left) gem_mmap_gtt (flink-race)
[61.220176] Subtest flink-race: SKIP (0.000s)
[61.282362] [007/155] (957s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[61.395242] Starting subtest: extended-modeset-hang-newfb-with-reset
[61.397713] Starting dynamic subtest: pipe-A
[75.391644] Dynamic subtest pipe-A: SUCCESS (13.977s)
[75.400629] Starting dynamic subtest: pipe-D
[91.268732] Dynamic subtest pipe-D: SUCCESS (15.869s)
[91.271229] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.850s)
[92.067572] [008/155] (926s left) syncobj_wait (multi-wait-submitted)
[92.132719] Starting subtest: multi-wait-submitted
[92.235510] Subtest multi-wait-submitted: SUCCESS (0.104s)
[92.321902] [009/155] (926s left) kms_getfb (getfb2-handle-protection)
[92.411587] Starting subtest: getfb2-handle-protection
[92.426149] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[92.526194] [010/155] (926s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[92.611451] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[92.616246] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[93.707406] [011/155] (924s left) gem_wait (write-wait)
[93.778046] Starting subtest: write-wait
[93.780440] Starting dynamic subtest: all-engines
[94.894391] Dynamic subtest all-engines: SUCCESS (1.119s)
[94.912995] Starting dynamic subtest: rcs0
[95.950565] Dynamic subtest rcs0: SUCCESS (1.055s)
[95.966734] Starting dynamic subtest: bcs0
[97.007538] Dynamic subtest bcs0: SUCCESS (1.055s)
[97.023474] Starting dynamic subtest: vcs0
[98.062714] Dynamic subtest vcs0: SUCCESS (1.054s)
[98.078055] Starting dynamic subtest: vcs1
[99.114811] Dynamic subtest vcs1: SUCCESS (1.051s)
[99.130965] Starting dynamic subtest: vecs0
[100.168093] Dynamic subtest vecs0: SUCCESS (1.052s)
[100.184026] Starting dynamic subtest: ccs0
[101.226949] Dynamic subtest ccs0: SUCCESS (1.058s)
[101.229703] Subtest write-wait: SUCCESS (7.451s)
[101.424945] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[101.428301] [012/155] (917s left) prime_vgem (coherency-blt)
[101.504881] Starting subtest: coherency-blt
[103.471524] Subtest coherency-blt: SUCCESS (1.964s)
[103.608217] [013/155] (915s left) kms_vblank (query-forked)
[103.703757] Starting subtest: query-forked
[103.705857] Starting dynamic subtest: pipe-A-eDP-1
[105.530415] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s)
[105.545105] Starting dynamic subtest: pipe-D-eDP-1
[108.033026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.502s)
[108.035413] Subtest query-forked: SUCCESS (4.331s)
[108.889690] [014/155] (909s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[108.986103] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[108.990592] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[109.077654] [015/155] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[109.170795] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[109.175092] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[109.268969] [016/155] (909s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[109.357026] Starting subtest: multiplane-rotation-cropping-top
[126.848471] Subtest multiplane-rotation-cropping-top: SUCCESS (17.493s)
[126.965745] [017/155] (891s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[127.078976] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[128.170906] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.093s)
[128.292881] [018/155] (890s left) gem_create (create-clear)
[128.342484] Starting subtest: create-clear
[128.344252] Starting dynamic subtest: smem0
[161.038111] Dynamic subtest smem0: SUCCESS (32.688s)
[161.040123] Subtest create-clear: SUCCESS (32.690s)
[161.228922] [019/155] (857s left) kms_chamelium_hpd (vga-hpd)
[161.612647] Subtest vga-hpd: SKIP (0.000s)
[162.394949] [020/155] (856s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[162.493683] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[162.498291] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[162.583199] [021/155] (856s left) kms_big_fb (linear-8bpp-rotate-90)
[162.695175] Starting subtest: linear-8bpp-rotate-90
[162.716024] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[162.819646] [022/155] (856s left) gem_lmem_swapping (verify)
[162.861371] Subtest verify: SKIP (0.000s)
[162.905125] [023/155] (856s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[163.008739] Starting subtest: y-tiled-64bpp-rotate-180
[163.012900] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[163.106627] [024/155] (856s left) kms_dsc (dsc-with-output-formats)
[163.203378] Starting subtest: dsc-with-output-formats
[163.225484] Subtest dsc-with-output-formats: SKIP (0.001s)
[163.277893] [025/155] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[163.375162] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[163.378698] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.458210] [026/155] (855s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[163.565534] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[163.568995] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[163.646202] [027/155] (855s left) api_intel_bb (purge-bb)
[163.691616] Starting subtest: purge-bb
[163.696058] Subtest purge-bb: SUCCESS (0.006s)
[163.818846] [028/155] (855s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[163.917615] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[163.921368] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[163.988424] [029/155] (855s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[164.082701] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[164.086062] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[164.169689] [030/155] (855s left) kms_flip (plain-flip-ts-check)
[164.258365] Starting subtest: plain-flip-ts-check
[164.260471] Starting dynamic subtest: A-eDP1
[173.105080] Dynamic subtest A-eDP1: SUCCESS (8.844s)
[173.114620] Starting dynamic subtest: B-eDP1
[181.927831] Dynamic subtest B-eDP1: SUCCESS (8.820s)
[181.941156] Starting dynamic subtest: C-eDP1
[190.748232] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[190.757282] Starting dynamic subtest: D-eDP1
[199.580090] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[199.585431] Subtest plain-flip-ts-check: SUCCESS (35.323s)
[200.752659] [031/155] (818s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[200.863716] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[208.293238] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.434s)
[208.417599] [032/155] (811s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[208.519195] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[208.521085] Starting dynamic subtest: pipe-A-eDP-1
[210.870428] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.352s)
[210.879519] Starting dynamic subtest: pipe-B-eDP-1
[213.306781] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.435s)
[213.315643] Starting dynamic subtest: pipe-C-eDP-1
[215.491331] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.183s)
[215.501075] Starting dynamic subtest: pipe-D-eDP-1
[217.712372] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.220s)
[217.714361] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.195s)
[218.906803] [033/155] (800s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[218.998116] Starting subtest: basic-max-pipe-crc-check
[219.002838] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[219.045014] [034/155] (800s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[219.152727] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[219.156874] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[219.257393] [035/155] (800s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-onoff)
[219.351765] Starting subtest: hdr-2p-primscrn-spr-indfb-onoff
[219.356254] Subtest hdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[219.458513] [036/155] (800s left) gem_softpin (allocator-basic-reserve)
[219.526537] Starting subtest: allocator-basic-reserve
[219.599092] Subtest allocator-basic-reserve: SUCCESS (0.072s)
[219.723435] [037/155] (800s left) gem_exec_whisper (basic-queues-priority)
[219.785804] Starting subtest: basic-queues-priority
[244.333144] Subtest basic-queues-priority: SUCCESS (24.545s)
[244.517423] [038/155] (775s left) gem_ctx_persistence (legacy-engines-hostile)
[244.593320] Starting subtest: legacy-engines-hostile
[244.595218] Starting dynamic subtest: render
[244.692904] Dynamic subtest render: SUCCESS (0.101s)
[244.704317] Starting dynamic subtest: bsd1
[244.792904] Dynamic subtest bsd1: SUCCESS (0.097s)
[244.804704] Starting dynamic subtest: bsd2
[244.885736] Dynamic subtest bsd2: SUCCESS (0.090s)
[244.897580] Starting dynamic subtest: blt
[244.962707] Dynamic subtest blt: SUCCESS (0.074s)
[244.975119] Starting dynamic subtest: vebox
[245.104662] Dynamic subtest vebox: SUCCESS (0.140s)
[245.107274] Subtest legacy-engines-hostile: SUCCESS (0.516s)
[245.190863] [039/155] (774s left) gem_exec_gttfill (basic)
[245.257158] Starting subtest: basic
[248.616514] Subtest basic: SUCCESS (3.359s)
[248.807209] [040/155] (771s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[248.964346] Starting subtest: x-tiled-16bpp-rotate-0
[250.275489] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.312s)
[250.397984] [041/155] (769s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[250.505719] Starting subtest: fbchdr-farfromfence-mmap-gtt
[250.509096] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[250.611984] [042/155] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[250.717883] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[250.721517] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[250.816880] [043/155] (769s left) gem_partial_pwrite_pread (writes-after-reads)
[250.880549] Subtest writes-after-reads: SKIP (0.000s)
[250.962349] [044/155] (769s left) gem_ctx_shared (q-in-order)
[251.024289] Starting subtest: Q-in-order
[251.026333] Starting dynamic subtest: rcs0
[251.134484] Dynamic subtest rcs0: SUCCESS (0.107s)
[251.151746] Starting dynamic subtest: vcs0
[251.229471] Dynamic subtest vcs0: SUCCESS (0.095s)
[251.248689] Starting dynamic subtest: vcs1
[251.312751] Dynamic subtest vcs1: SUCCESS (0.082s)
[251.329993] Starting dynamic subtest: vecs0
[251.392399] Dynamic subtest vecs0: SUCCESS (0.079s)
[251.408261] Starting dynamic subtest: ccs0
[251.483929] Dynamic subtest ccs0: SUCCESS (0.088s)
[251.486402] Subtest Q-in-order: SUCCESS (0.459s)
[252.378934] [045/155] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[252.495157] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[256.202960] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.715s)
[257.408767] [046/155] (762s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[257.511659] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[257.515919] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[257.606093] [047/155] (762s left) kms_psr (pr-basic)
[257.695927] Starting subtest: pr-basic
[257.700461] Subtest pr-basic: SKIP (0.000s)
[257.769771] [048/155] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[257.873586] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[261.592151] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.724s)
[262.811107] [049/155] (757s left) kms_cursor_crc (cursor-offscreen-64x21)
[263.017707] Starting subtest: cursor-offscreen-64x21
[263.067169] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[263.308631] [050/155] (757s left) kms_flip (2x-flip-vs-modeset)
[263.404109] Starting subtest: 2x-flip-vs-modeset
[263.414443] Subtest 2x-flip-vs-modeset: SKIP (0.012s)
[263.535808] [051/155] (756s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[263.634850] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[263.639098] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.750961] [052/155] (756s left) gen9_exec_parse (bb-start-param)
[263.821456] Subtest bb-start-param: SKIP (0.000s)
[263.893276] [053/155] (756s left) vgem_slow (nohang)
[263.935712] Starting subtest: nohang
[274.398193] Subtest nohang: SUCCESS (10.461s)
[274.517760] [054/155] (746s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[274.618716] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[274.622723] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[274.721614] [055/155] (745s left) core_sysfs (read-all-entries)
[274.773884] Starting subtest: read-all-entries
[274.776325] Subtest read-all-entries: SUCCESS (0.004s)
[274.886274] [056/155] (745s left) gem_exec_params (invalid-fence-in)
[274.943576] Starting subtest: invalid-fence-in
[274.945823] Subtest invalid-fence-in: SUCCESS (0.000s)
[275.054521] [057/155] (745s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[275.178981] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[275.183626] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[275.327547] [058/155] (745s left) kms_async_flips (async-flip-hang)
[275.417241] Starting subtest: async-flip-hang
[275.791192] Starting dynamic subtest: pipe-A-eDP-1
[290.782643] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.988s)
[291.169594] Starting dynamic subtest: pipe-B-eDP-1
[306.782807] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.617s)
[307.173541] Starting dynamic subtest: pipe-C-eDP-1
[322.778991] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.612s)
[323.160162] Starting dynamic subtest: pipe-D-eDP-1
[338.780345] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.625s)
[338.782786] Subtest async-flip-hang: SUCCESS (63.359s)
[339.965192] [059/155] (680s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[340.062645] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[340.067162] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[340.178505] [060/155] (680s left) gem_mmap_offset (ptrace)
[340.234243] Starting subtest: ptrace
[340.239238] Starting dynamic subtest: smem0-wb
[340.259310] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[340.271618] Starting dynamic subtest: smem0-wc
[340.283803] Dynamic subtest smem0-wc: SUCCESS (0.023s)
[340.293221] Starting dynamic subtest: smem0-uc
[340.304541] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[340.307343] Subtest ptrace: SUCCESS (0.070s)
[340.430023] [061/155] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[340.534392] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[340.538339] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[340.637165] [062/155] (680s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[340.688996] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[340.693463] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[340.894751] [063/155] (680s left) gem_exec_reloc (basic-cpu-read)
[340.963192] Subtest basic-cpu-read: SKIP (0.000s)
[341.033433] [064/155] (679s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[341.132422] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[341.136969] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[341.222719] [065/155] (679s left) gem_exec_schedule (preempt-contexts)
[341.292049] Starting subtest: preempt-contexts
[341.294440] Starting dynamic subtest: rcs0
[341.346418] Dynamic subtest rcs0: SUCCESS (0.058s)
[341.358892] Starting dynamic subtest: bcs0
[341.399638] Dynamic subtest bcs0: SUCCESS (0.053s)
[341.410410] Starting dynamic subtest: vcs0
[341.450759] Dynamic subtest vcs0: SUCCESS (0.050s)
[341.460495] Starting dynamic subtest: vcs1
[341.494281] Dynamic subtest vcs1: SUCCESS (0.043s)
[341.504050] Starting dynamic subtest: vecs0
[341.540906] Dynamic subtest vecs0: SUCCESS (0.045s)
[341.550902] Starting dynamic subtest: ccs0
[341.588621] Dynamic subtest ccs0: SUCCESS (0.048s)
[341.590944] Subtest preempt-contexts: SUCCESS (0.301s)
[343.398265] [066/155] (677s left) syncobj_timeline (reset-during-wait-for-submit)
[343.455447] Starting subtest: reset-during-wait-for-submit
[343.559405] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[343.635799] [067/155] (677s left) kms_cursor_legacy (forked-move)
[343.755658] Starting subtest: forked-move
[343.758048] Starting dynamic subtest: pipe-A
[349.230210] Dynamic subtest pipe-A: SUCCESS (5.471s)
[349.242862] Starting dynamic subtest: pipe-B
[354.700773] Dynamic subtest pipe-B: SUCCESS (5.468s)
[354.712357] Starting dynamic subtest: pipe-C
[360.175658] Dynamic subtest pipe-C: SUCCESS (5.471s)
[360.188848] Starting dynamic subtest: pipe-D
[365.660553] Dynamic subtest pipe-D: SUCCESS (5.482s)
[365.673332] Starting dynamic subtest: all-pipes
[371.181165] Dynamic subtest all-pipes: SUCCESS (5.518s)
[371.183793] Subtest forked-move: SUCCESS (27.424s)
[371.329693] [068/155] (649s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[371.430954] Starting subtest: primary-yf-tiled-reflect-x-270
[371.435269] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[371.503662] [069/155] (649s left) gem_exec_big (single)
[371.559365] Starting subtest: single
[373.800609] Subtest single: SUCCESS (2.239s)
[373.995696] [070/155] (647s left) gem_exec_whisper (basic-forked-all)
[374.108763] Starting subtest: basic-forked-all
[389.313614] Subtest basic-forked-all: SUCCESS (15.202s)
[389.514712] [071/155] (631s left) i915_pm_rpm (gem-execbuf)
[391.485450] Starting subtest: gem-execbuf
[391.488306] Starting dynamic subtest: smem0
[393.241055] Dynamic subtest smem0: SUCCESS (1.753s)
[393.243415] Subtest gem-execbuf: SUCCESS (1.756s)
[393.324474] [072/155] (627s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[393.434246] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[393.438626] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[393.524837] [073/155] (627s left) gem_tiled_pread_pwrite
[393.665685] [074/155] (627s left) perf_pmu (init-busy)
[393.713042] Starting subtest: init-busy
[393.715407] Starting dynamic subtest: rcs0
[393.717997] Dynamic subtest rcs0: SUCCESS (0.002s)
[393.728056] Starting dynamic subtest: bcs0
[393.730154] Dynamic subtest bcs0: SUCCESS (0.000s)
[393.739968] Starting dynamic subtest: vcs0
[393.742115] Dynamic subtest vcs0: SUCCESS (0.001s)
[393.751630] Starting dynamic subtest: vcs1
[393.753744] Dynamic subtest vcs1: SUCCESS (0.001s)
[393.763060] Starting dynamic subtest: vecs0
[393.766081] Dynamic subtest vecs0: SUCCESS (0.001s)
[393.775371] Starting dynamic subtest: ccs0
[393.777265] Dynamic subtest ccs0: SUCCESS (0.000s)
[393.779535] Subtest init-busy: SUCCESS (0.009s)
[393.837731] [075/155] (627s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[393.933226] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[393.937185] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[394.009317] [076/155] (627s left) gem_mmap_wc (fault-concurrent)
[394.064396] Subtest fault-concurrent: SKIP (0.000s)
[394.125320] [077/155] (627s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[394.223708] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[394.226995] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[394.343245] [078/155] (627s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[394.451817] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[394.455169] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[394.558138] [079/155] (627s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[394.652569] Starting subtest: fbchdr-rgb101010-draw-blt
[394.656759] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[394.740496] [080/155] (626s left) kms_invalid_mode (clock-too-high)
[394.831249] Starting subtest: clock-too-high
[394.833161] Starting dynamic subtest: pipe-A-eDP-1
[395.114117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[395.126659] Starting dynamic subtest: pipe-B-eDP-1
[395.130977] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[395.141075] Starting dynamic subtest: pipe-C-eDP-1
[395.145063] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[395.155780] Starting dynamic subtest: pipe-D-eDP-1
[395.160747] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[395.163248] Subtest clock-too-high: SUCCESS (0.292s)
[395.924953] [081/155] (625s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[396.037570] Starting subtest: fbc-rgb101010-draw-render
[398.559776] Subtest fbc-rgb101010-draw-render: SUCCESS (2.529s)
[399.743862] [082/155] (621s left) gem_mmap_wc (write-read-distinct)
[399.813641] Subtest write-read-distinct: SKIP (0.000s)
[399.877675] [083/155] (621s left) perf (global-sseu-config-invalid)
[400.015261] Starting subtest: global-sseu-config-invalid
[400.019741] Subtest global-sseu-config-invalid: SKIP (0.000s)
[400.061973] [084/155] (621s left) kms_pm_rpm (legacy-planes)
[401.583316] Starting subtest: legacy-planes
[401.585468] Starting dynamic subtest: plane-65
[409.870035] Dynamic subtest plane-65: SUCCESS (8.290s)
[409.882604] Starting dynamic subtest: plane-95
[418.198641] Dynamic subtest plane-95: SUCCESS (8.325s)
[418.210694] Starting dynamic subtest: plane-125
[426.611180] Dynamic subtest plane-125: SUCCESS (8.410s)
[426.623173] Starting dynamic subtest: plane-135
[434.926969] Dynamic subtest plane-135: SUCCESS (8.313s)
[434.929753] Subtest legacy-planes: SUCCESS (33.347s)
[435.319927] [085/155] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[435.425791] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[435.430241] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[435.512556] [086/155] (586s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[435.611155] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[435.615615] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[435.697620] [087/155] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[435.805610] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[435.810064] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[435.925318] [088/155] (586s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[436.198028] Starting subtest: cursor-rapid-movement-256x85
[436.246340] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[436.435579] [089/155] (585s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[436.530143] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[436.532084] Starting dynamic subtest: pipe-A
[436.550405] Dynamic subtest pipe-A: SKIP (0.018s)
[436.561455] Starting dynamic subtest: pipe-B
[436.585285] Dynamic subtest pipe-B: SKIP (0.032s)
[436.594844] Starting dynamic subtest: pipe-C
[436.616791] Dynamic subtest pipe-C: SKIP (0.032s)
[436.626206] Starting dynamic subtest: pipe-D
[436.650231] Dynamic subtest pipe-D: SKIP (0.032s)
[436.653854] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.117s)
[436.756219] [090/155] (585s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[436.857137] Starting subtest: fbc-psr2-primary-mmap-gtt
[436.859018] Starting dynamic subtest: eDP-1
[436.862429] Dynamic subtest eDP-1: SKIP (0.000s)
[436.865763] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[436.930592] [091/155] (585s left) sw_sync (sync_busy_fork_unixsocket)
[436.966473] Starting subtest: sync_busy_fork_unixsocket
[436.976091] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[437.030457] [092/155] (585s left) gem_exec_flush (basic-uc-rw-default)
[437.083560] Starting subtest: basic-uc-rw-default
[442.540605] Subtest basic-uc-rw-default: SUCCESS (5.456s)
[442.729823] [093/155] (579s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[442.830898] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[442.835486] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[442.916742] [094/155] (579s left) kms_color (deep-color)
[443.006839] Starting subtest: deep-color
[444.077093] Starting dynamic subtest: pipe-A-eDP-1-gamma
[444.801582] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.726s)
[444.812111] Starting dynamic subtest: pipe-A-eDP-1-degamma
[446.288079] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.485s)
[446.298893] Starting dynamic subtest: pipe-A-eDP-1-ctm
[447.719895] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.430s)
[448.492864] Starting dynamic subtest: pipe-B-eDP-1-gamma
[449.198455] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.713s)
[449.208459] Starting dynamic subtest: pipe-B-eDP-1-degamma
[450.707424] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.508s)
[450.718209] Starting dynamic subtest: pipe-B-eDP-1-ctm
[452.131788] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.425s)
[452.908348] Starting dynamic subtest: pipe-C-eDP-1-gamma
[453.603225] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.702s)
[453.618970] Starting dynamic subtest: pipe-C-eDP-1-degamma
[455.078757] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.476s)
[455.089832] Starting dynamic subtest: pipe-C-eDP-1-ctm
[456.497069] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.415s)
[457.294464] Starting dynamic subtest: pipe-D-eDP-1-gamma
[457.994199] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.709s)
[458.004267] Starting dynamic subtest: pipe-D-eDP-1-degamma
[459.465363] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.471s)
[459.475300] Starting dynamic subtest: pipe-D-eDP-1-ctm
[460.883711] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.417s)
[460.886122] Subtest deep-color: SUCCESS (17.877s)
[461.739467] [095/155] (560s left) kms_pm_backlight (fade)
[461.839055] Starting subtest: fade
[461.887967] Starting dynamic subtest: eDP-1
[464.899110] Dynamic subtest eDP-1: SUCCESS (3.006s)
[464.901256] Subtest fade: SUCCESS (3.057s)
[465.759516] [096/155] (556s left) gem_exec_reloc (basic-gtt-active)
[465.823881] Subtest basic-gtt-active: SKIP (0.000s)
[465.905480] [097/155] (556s left) gem_mmap (basic)
[465.963323] Subtest basic: SKIP (0.000s)
[466.030974] [098/155] (556s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[466.080759] Starting subtest: single-wait-for-submit-available-signaled
[466.083063] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[466.180137] [099/155] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[466.275373] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[466.279325] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[466.380671] [100/155] (556s left) gem_exec_reloc (basic-wc-gtt)
[466.437952] Subtest basic-wc-gtt: SKIP (0.000s)
[466.518034] [101/155] (556s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[466.564904] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[466.666248] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[466.745883] [102/155] (555s left) gem_exec_fence (syncobj-unused-fence)
[467.185242] Starting subtest: syncobj-unused-fence
[467.191065] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[468.378465] [103/155] (554s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[468.471791] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[468.476193] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[468.578896] [104/155] (554s left) kms_cursor_edge_walk (64x64-left-edge)
[468.671502] Starting subtest: 64x64-left-edge
[468.673821] Starting dynamic subtest: pipe-A-eDP-1
[472.120582] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[472.131493] Starting dynamic subtest: pipe-D-eDP-1
[475.258276] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s)
[475.260522] Subtest 64x64-left-edge: SUCCESS (6.589s)
[476.075229] [105/155] (546s left) syncobj_timeline (invalid-query-zero-handles)
[476.136925] Starting subtest: invalid-query-zero-handles
[476.139608] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[476.253054] [106/155] (546s left) gem_bad_reloc (negative-reloc-lut)
[476.312905] Subtest negative-reloc-lut: SKIP (0.000s)
[476.388970] [107/155] (546s left) kms_addfb_basic (invalid-set-prop)
[476.463508] Starting subtest: invalid-set-prop
[476.465655] Subtest invalid-set-prop: SUCCESS (0.000s)
[476.609684] [108/155] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[476.712293] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[500.126277] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.418s)
[500.262610] [109/155] (522s left) gem_softpin (noreloc-interruptible)
[500.328486] Starting subtest: noreloc-interruptible
[505.757986] Subtest noreloc-interruptible: SUCCESS (5.427s)
[505.887148] [110/155] (517s left) gem_exec_balancer (parallel-bb-first)
[506.154026] Starting subtest: parallel-bb-first
[507.138586] Subtest parallel-bb-first: SUCCESS (0.984s)
[508.342937] [111/155] (514s left) kms_async_flips (test-cursor)
[508.447872] Starting subtest: test-cursor
[508.838853] Starting dynamic subtest: pipe-A-eDP-1
[509.598237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s)
[509.970126] Starting dynamic subtest: pipe-B-eDP-1
[510.720347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[511.106722] Starting dynamic subtest: pipe-C-eDP-1
[511.862584] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[512.234911] Starting dynamic subtest: pipe-D-eDP-1
[513.000871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[513.003230] Subtest test-cursor: SUCCESS (4.555s)
[514.186664] [112/155] (508s left) gem_pxp (reject-modify-context-protection-off-3)
[514.316959] Starting subtest: reject-modify-context-protection-off-3
[514.319771] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[514.459216] [113/155] (508s left) syncobj_timeline (host-signal-ordered)
[514.506996] Starting subtest: host-signal-ordered
[514.509219] Subtest host-signal-ordered: SUCCESS (0.000s)
[514.620411] [114/155] (508s left) kms_plane_multiple (tiling-y)
[514.719921] Starting subtest: tiling-y
[514.724214] Subtest tiling-y: SKIP (0.000s)
[514.792679] [115/155] (508s left) kms_flip (flip-vs-suspend)
[514.894290] Starting subtest: flip-vs-suspend
[514.896652] Starting dynamic subtest: A-eDP1
[660.080060] Dynamic subtest A-eDP1: SUCCESS (11.359s)
[660.082445] Subtest flip-vs-suspend: SUCCESS (11.361s)
[660.215546] [116/155] (362s left) i915_drm_fdinfo (context-close-stress)
[660.267896] Starting subtest: context-close-stress
[671.096501] Subtest context-close-stress: SUCCESS (10.745s)
[671.196156] [117/155] (352s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[671.462942] Starting subtest: cursorA-vs-flipA-varying-size
[682.630646] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.140s)
[683.487885] [118/155] (339s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[683.598526] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[684.456802] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.859s)
[684.608387] [119/155] (338s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[684.715032] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[684.720140] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[684.819166] [120/155] (338s left) kms_psr (pr-cursor-render)
[684.912356] Starting subtest: pr-cursor-render
[684.917558] Subtest pr-cursor-render: SKIP (0.000s)
[685.012213] [121/155] (338s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[685.104533] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[692.163421] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.060s)
[692.312582] [122/155] (331s left) kms_psr (psr2-sprite-plane-move)
[692.412422] Starting subtest: psr2-sprite-plane-move
[692.415145] Starting dynamic subtest: eDP-1
[694.155445] Dynamic subtest eDP-1: SUCCESS (1.741s)
[694.158420] Subtest psr2-sprite-plane-move: SUCCESS (1.742s)
[694.997370] [123/155] (328s left) kms_plane_lowres (tiling-none)
[695.088356] Starting subtest: tiling-none
[695.091009] Starting dynamic subtest: pipe-A-eDP-1
[695.096245] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[695.387461] Starting dynamic subtest: pipe-B-eDP-1
[695.392849] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[695.403704] Starting dynamic subtest: pipe-C-eDP-1
[695.408747] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[695.420512] Starting dynamic subtest: pipe-D-eDP-1
[695.425497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[695.430460] Subtest tiling-none: SKIP (0.299s)
[696.234663] [124/155] (327s left) api_intel_allocator (standalone)
[696.286417] Starting subtest: standalone
[696.298267] Subtest standalone: SUCCESS (0.016s)
[696.424739] [125/155] (327s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[696.513550] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[696.516357] Starting dynamic subtest: pipe-A-eDP-1
[696.953662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[696.966594] Starting dynamic subtest: pipe-B-eDP-1
[696.990304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[697.002145] Starting dynamic subtest: pipe-C-eDP-1
[697.025341] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[697.036269] Starting dynamic subtest: pipe-D-eDP-1
[697.059444] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[697.062301] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.457s)
[699.309486] [126/155] (324s left) perf (sysctl-defaults)
[699.391141] Starting subtest: sysctl-defaults
[699.393483] Subtest sysctl-defaults: SUCCESS (0.000s)
[699.461620] [127/155] (324s left) gem_fence_thrash (bo-write-verify-threaded-none)
[699.495491] Starting subtest: bo-write-verify-threaded-none
[699.520424] Subtest bo-write-verify-threaded-none: SKIP (0.022s)
[699.583277] [128/155] (324s left) i915_query (query-topology-coherent-slice-mask)
[699.647885] Starting subtest: query-topology-coherent-slice-mask
[699.652813] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[699.756456] [129/155] (324s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[699.864530] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[699.867056] Starting dynamic subtest: pipe-A-eDP-1
[699.948796] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[699.960437] Starting dynamic subtest: pipe-B-eDP-1
[701.087317] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[701.092619] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.225s)
[702.273938] [130/155] (321s left) kms_pm_rpm (system-suspend-modeset)
[704.303655] Starting subtest: system-suspend-modeset
[723.636894] Subtest system-suspend-modeset: SUCCESS (4.621s)
[724.027519] [131/155] (299s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[724.128069] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[724.133366] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[724.240057] [132/155] (299s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[724.353631] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[726.835999] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.465s)
[728.046430] [133/155] (295s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[728.427140] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[729.256265] [134/155] (294s left) kms_chamelium_color (ctm-0-75)
[729.350288] Subtest ctm-0-75: SKIP (0.000s)
[729.405936] [135/155] (294s left) gem_exec_schedule (semaphore-codependency)
[729.482623] Starting subtest: semaphore-codependency
[729.485522] Subtest semaphore-codependency: SUCCESS (0.013s)
[729.820015] [136/155] (294s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[730.390606] Starting subtest: syncobj-timeline-multiple-ext-nodes
[730.397517] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[731.889480] [137/155] (292s left) perf (oa-exponents)
[731.982228] Starting subtest: oa-exponents
[731.984560] Starting dynamic subtest: 0-rcs0
[733.783233] Dynamic subtest 0-rcs0: SUCCESS (1.792s)
[733.795952] Starting dynamic subtest: 1-vecs0
[735.617670] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[735.620672] Subtest oa-exponents: SUCCESS (3.622s)
[735.671323] [138/155] (288s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[735.781150] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[739.834561] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.051s)
[741.016590] [139/155] (283s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[741.081524] Starting subtest: rel-constants-invalid-rel-gen5
[741.084471] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[741.171566] [140/155] (283s left) i915_fb_tiling (basic-x-tiling)
[741.229353] Subtest basic-x-tiling: SKIP (0.000s)
[741.288303] [141/155] (283s left) gem_userptr_blits (unsync-unmap-cycles)
[741.358438] Subtest unsync-unmap-cycles: SKIP (0.000s)
[741.478022] [142/155] (282s left) kms_vblank (ts-continuation-suspend)
[741.582593] Starting subtest: ts-continuation-suspend
[741.585343] Starting dynamic subtest: pipe-A-eDP-1
[758.349471] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.536s)
[758.367573] Starting dynamic subtest: pipe-D-eDP-1
[775.384151] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.203s)
[775.386539] Subtest ts-continuation-suspend: SUCCESS (3.744s)
[776.204696] [143/155] (248s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[776.308429] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[776.313616] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[776.422431] [144/155] (248s left) perf (oa-formats)
[776.512293] Starting subtest: oa-formats
[776.515194] Starting dynamic subtest: 0-rcs0
[776.524962] Dynamic subtest 0-rcs0: SUCCESS (0.012s)
[776.536840] Starting dynamic subtest: 1-vecs0
[776.550012] Dynamic subtest 1-vecs0: SUCCESS (0.024s)
[776.552942] Subtest oa-formats: SUCCESS (0.038s)
[776.594911] [145/155] (247s left) i915_selftest (live)
[778.450560] Starting subtest: live
[778.453608] Starting dynamic subtest: sanitycheck
[783.680940] Dynamic subtest sanitycheck: SUCCESS (5.192s)
[783.692165] Starting dynamic subtest: uncore
[787.319322] Dynamic subtest uncore: SUCCESS (3.622s)
[787.330632] Starting dynamic subtest: workarounds
[792.848492] Dynamic subtest workarounds: SUCCESS (5.515s)
[792.862969] Starting dynamic subtest: gt_engines
[798.262415] Dynamic subtest gt_engines: SUCCESS (5.405s)
[798.272868] Starting dynamic subtest: gt_timelines
[816.671606] Dynamic subtest gt_timelines: SUCCESS (18.401s)
[816.683499] Starting dynamic subtest: gt_contexts
[820.300760] Dynamic subtest gt_contexts: SUCCESS (3.627s)
[820.311727] Starting dynamic subtest: gt_lrc
[827.320112] Dynamic subtest gt_lrc: SUCCESS (7.016s)
[827.331839] Starting dynamic subtest: gt_mocs
[831.135575] Dynamic subtest gt_mocs: SUCCESS (3.813s)
[831.147320] Starting dynamic subtest: gt_pm
[836.820703] Dynamic subtest gt_pm: SUCCESS (5.681s)
[836.830068] Starting dynamic subtest: gt_heartbeat
[840.436682] Dynamic subtest gt_heartbeat: SUCCESS (3.614s)
[840.450426] Starting dynamic subtest: gt_tlb
[850.694819] Dynamic subtest gt_tlb: SUCCESS (10.253s)
[850.705839] Starting dynamic subtest: requests
[863.353168] Dynamic subtest requests: SUCCESS (12.651s)
[863.364582] Starting dynamic subtest: migrate
[870.046897] Dynamic subtest migrate: SUCCESS (6.671s)
[870.056191] Starting dynamic subtest: active
[875.248535] Dynamic subtest active: SUCCESS (5.220s)
[875.259823] Starting dynamic subtest: objects
[879.656169] Dynamic subtest objects: SUCCESS (4.408s)
[879.668120] Starting dynamic subtest: mman
[883.849228] Dynamic subtest mman: SUCCESS (4.191s)
[883.861191] Starting dynamic subtest: dmabuf
[889.080004] Dynamic subtest dmabuf: SUCCESS (5.229s)
[889.091587] Starting dynamic subtest: vma
[892.661835] Dynamic subtest vma: SUCCESS (3.581s)
[892.673468] Starting dynamic subtest: coherency
[898.608828] Dynamic subtest coherency: SUCCESS (5.945s)
[898.620359] Starting dynamic subtest: gtt
[909.437834] Dynamic subtest gtt: SUCCESS (10.825s)
[909.454932] Starting dynamic subtest: gem
[916.525353] Dynamic subtest gem: SUCCESS (7.084s)
[916.536835] Starting dynamic subtest: evict
[921.440172] Dynamic subtest evict: SUCCESS (4.912s)
[921.451339] Starting dynamic subtest: hugepages
[931.068020] Dynamic subtest hugepages: SUCCESS (9.624s)
[931.079400] Starting dynamic subtest: gem_contexts
[958.730191] Dynamic subtest gem_contexts: SUCCESS (27.655s)
[958.745497] Starting dynamic subtest: client
[962.385610] Dynamic subtest client: SUCCESS (3.653s)
[962.397107] Starting dynamic subtest: gem_migrate
[966.001200] Dynamic subtest gem_migrate: SUCCESS (3.614s)
[966.012756] Starting dynamic subtest: reset
[971.250714] Dynamic subtest reset: SUCCESS (5.247s)
[971.260997] Starting dynamic subtest: memory_region
[974.834499] Dynamic subtest memory_region: SUCCESS (3.581s)
[974.845773] Starting dynamic subtest: hangcheck
[988.657195] Dynamic subtest hangcheck: SUCCESS (13.818s)
[988.668010] Starting dynamic subtest: execlists
[992.257956] Dynamic subtest execlists: SUCCESS (3.598s)
[992.273397] Starting dynamic subtest: ring_submission
[995.902553] Dynamic subtest ring_submission: SUCCESS (3.642s)
[995.913472] Starting dynamic subtest: perf
[999.652348] Dynamic subtest perf: SUCCESS (3.747s)
[999.663446] Starting dynamic subtest: slpc
[1012.607097] Dynamic subtest slpc: SUCCESS (12.957s)
[1012.618334] Starting dynamic subtest: guc
[1017.434841] Dynamic subtest guc: SUCCESS (4.827s)
[1017.446545] Starting dynamic subtest: guc_multi_lrc
[1022.618031] Dynamic subtest guc_multi_lrc: SUCCESS (5.182s)
[1022.629625] Starting dynamic subtest: guc_hang
[1026.977333] Dynamic subtest guc_hang: SUCCESS (4.358s)
[1026.991181] Starting dynamic subtest: late_gt_pm
[1032.194573] Dynamic subtest late_gt_pm: SUCCESS (5.216s)
[1032.197525] Subtest live: SUCCESS (253.640s)
[1032.219975] Overall timeout time exceeded, stopping.
[1032.230433] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1032.231198] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[1032.231344] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_ctx_bad_destroy
results: parsing output: 3/ for test: gen3_render_tiledx_blits
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_busy
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_create
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_dsc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_multipipe_modeset
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: gem_exec_gttfill
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: vgem_slow
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: core_sysfs
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: gem_exec_big
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_tiled_pread_pwrite
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_invalid_mode
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: sw_sync
results: parsing output: 91/ for test: gem_exec_flush
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_color
results: parsing output: 94/ for test: kms_pm_backlight
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_mmap
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_bad_reloc
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_pxp
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_plane_multiple
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_plane_lowres
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_fence_thrash
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_chamelium_edid
results: parsing output: 133/ for test: kms_chamelium_color
results: parsing output: 134/ for test: gem_exec_schedule
results: parsing output: 135/ for test: gem_exec_fence
results: parsing output: 136/ for test: perf
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_exec_params
results: parsing output: 139/ for test: i915_fb_tiling
results: parsing output: 140/ for test: gem_userptr_blits
results: parsing output: 141/ for test: kms_vblank
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: perf
results: parsing output: 144/ for test: i915_selftest
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 146/ for test: gem_ctx_isolation
results: no output, setting notrun
results: parsing output: 147/ for test: gem_close
results: no output, setting notrun
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 151/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 154/ for test: syncobj_wait
results: no output, setting notrun
Done.