[61.507426] Initializing watchdogs
[61.507473]   /dev/watchdog0
[61.522426] [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.527221] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.530192] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.533466] [001/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[61.660846] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[68.480917] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.793s)
[68.604670] [002/131] (953s left) gem_ctx_bad_destroy (invalid-default-ctx)
[68.661610] Starting subtest: invalid-default-ctx
[68.663762] Subtest invalid-default-ctx: SUCCESS (0.000s)
[68.734652] [003/131] (953s left) gem_exec_schedule (preempt-self)
[68.812499] Starting subtest: preempt-self
[68.814751] Starting dynamic subtest: rcs0
[68.829741] Dynamic subtest rcs0: SUCCESS (0.021s)
[68.840625] Starting dynamic subtest: bcs0
[68.848790] Dynamic subtest bcs0: SUCCESS (0.019s)
[68.857154] Starting dynamic subtest: vcs0
[68.866244] Dynamic subtest vcs0: SUCCESS (0.017s)
[68.873984] Starting dynamic subtest: vcs1
[68.883091] Dynamic subtest vcs1: SUCCESS (0.017s)
[68.891018] Starting dynamic subtest: vecs0
[68.900196] Dynamic subtest vecs0: SUCCESS (0.017s)
[68.908080] Starting dynamic subtest: ccs0
[68.917848] Dynamic subtest ccs0: SUCCESS (0.017s)
[68.920089] Subtest preempt-self: SUCCESS (0.110s)
[70.355540] [004/131] (951s left) perf (gen8-unprivileged-single-ctx-counters)
[70.485271] Starting subtest: gen8-unprivileged-single-ctx-counters
[70.489082] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[70.531211] [005/131] (951s left) kms_color (deep-color)
[70.629091] Starting subtest: deep-color
[71.722883] Starting dynamic subtest: pipe-A-eDP-1-gamma
[72.437346] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.713s)
[72.447649] Starting dynamic subtest: pipe-A-eDP-1-degamma
[73.928300] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.489s)
[73.938074] Starting dynamic subtest: pipe-A-eDP-1-ctm
[75.348940] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.418s)
[76.112297] Starting dynamic subtest: pipe-B-eDP-1-gamma
[76.868088] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.761s)
[76.877215] Starting dynamic subtest: pipe-B-eDP-1-degamma
[78.319951] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.449s)
[78.329437] Starting dynamic subtest: pipe-B-eDP-1-ctm
[79.747598] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.428s)
[80.508410] Starting dynamic subtest: pipe-C-eDP-1-gamma
[81.196957] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[81.206303] Starting dynamic subtest: pipe-C-eDP-1-degamma
[82.569804] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.373s)
[82.578998] Starting dynamic subtest: pipe-C-eDP-1-ctm
[84.032767] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.461s)
[84.806182] Starting dynamic subtest: pipe-D-eDP-1-gamma
[85.502425] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.703s)
[85.511690] Starting dynamic subtest: pipe-D-eDP-1-degamma
[86.961408] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.458s)
[86.970143] Starting dynamic subtest: pipe-D-eDP-1-ctm
[88.402906] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.441s)
[88.405344] Subtest deep-color: SUCCESS (17.758s)
[89.256016] [006/131] (932s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[89.326605] Starting subtest: invalid-bsd2-flag-on-vebox
[89.328872] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[89.416584] [007/131] (932s left) gem_ctx_persistence (hostile)
[89.476768] Starting subtest: hostile
[98.979026] Subtest hostile: SUCCESS (9.496s)
[99.101861] [008/131] (923s left) kms_chamelium_edid (dp-mode-timings)
[99.494227] Subtest dp-mode-timings: SKIP (0.000s)
[100.268678] [009/131] (922s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[100.329575] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[100.334258] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[100.517736] [010/131] (921s left) kms_cursor_crc (cursor-onscreen-512x170)
[100.799758] Starting subtest: cursor-onscreen-512x170
[100.804657] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[100.948946] [011/131] (921s left) kms_vblank (query-idle)
[101.038269] Starting subtest: query-idle
[101.040452] Starting dynamic subtest: pipe-A-eDP-1
[102.780614] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[102.801736] Starting dynamic subtest: pipe-D-eDP-1
[105.222532] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.440s)
[105.224823] Subtest query-idle: SUCCESS (4.184s)
[106.040951] [012/131] (916s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[106.144601] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[106.148700] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[106.241161] [013/131] (916s left) kms_plane (plane-position-hole-dpms)
[106.352284] Starting subtest: plane-position-hole-dpms
[106.888495] Starting dynamic subtest: pipe-A-plane-1
[109.234243] Dynamic subtest pipe-A-plane-1: SUCCESS (2.345s)
[109.243732] Starting dynamic subtest: pipe-A-plane-2
[111.607554] Dynamic subtest pipe-A-plane-2: SUCCESS (2.373s)
[111.617377] Starting dynamic subtest: pipe-A-plane-3
[113.959791] Dynamic subtest pipe-A-plane-3: SUCCESS (2.351s)
[113.968739] Starting dynamic subtest: pipe-A-plane-4
[116.328298] Dynamic subtest pipe-A-plane-4: SUCCESS (2.369s)
[116.336869] Starting dynamic subtest: pipe-A-plane-5
[116.354292] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[117.504416] Starting dynamic subtest: pipe-B-plane-1
[119.910330] Dynamic subtest pipe-B-plane-1: SUCCESS (2.413s)
[119.919621] Starting dynamic subtest: pipe-B-plane-2
[122.283542] Dynamic subtest pipe-B-plane-2: SUCCESS (2.372s)
[122.292911] Starting dynamic subtest: pipe-B-plane-3
[124.650373] Dynamic subtest pipe-B-plane-3: SUCCESS (2.366s)
[124.664193] Starting dynamic subtest: pipe-B-plane-4
[127.031267] Dynamic subtest pipe-B-plane-4: SUCCESS (2.380s)
[127.039692] Starting dynamic subtest: pipe-B-plane-5
[127.056778] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[127.059165] Subtest plane-position-hole-dpms: SUCCESS (20.701s)
[127.826946] [014/131] (894s left) gem_pread (snoop)
[127.888912] Subtest snoop: SKIP (0.000s)
[127.948613] [015/131] (894s left) gem_ctx_bad_destroy (double-destroy)
[127.999868] Starting subtest: double-destroy
[128.002286] Subtest double-destroy: SUCCESS (0.000s)
[128.073708] [016/131] (894s left) kms_flip (dpms-vs-vblank-race)
[128.168207] Starting subtest: dpms-vs-vblank-race
[128.170066] Starting dynamic subtest: A-eDP1
[133.109418] Dynamic subtest A-eDP1: SUCCESS (4.942s)
[133.118244] Starting dynamic subtest: B-eDP1
[136.707691] Dynamic subtest B-eDP1: SUCCESS (3.595s)
[136.716624] Starting dynamic subtest: C-eDP1
[141.334076] Dynamic subtest C-eDP1: SUCCESS (4.624s)
[141.343616] Starting dynamic subtest: D-eDP1
[145.954694] Dynamic subtest D-eDP1: SUCCESS (4.618s)
[145.956649] Subtest dpms-vs-vblank-race: SUCCESS (17.791s)
[146.840105] [017/131] (875s left) kms_getfb (getfb2-accept-nv12)
[146.952178] Starting subtest: getfb2-accept-nv12
[146.954520] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[147.059577] [018/131] (875s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[147.150251] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[147.154241] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[147.222011] [019/131] (875s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[147.291285] Starting subtest: etime-single-wait-for-submit-submitted
[147.393813] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[147.468974] [020/131] (875s left) kms_plane_scaling (planes-upscale-factor-0-25)
[147.553840] Starting subtest: planes-upscale-factor-0-25
[147.556082] Starting dynamic subtest: pipe-A
[147.614188] Dynamic subtest pipe-A: SUCCESS (0.062s)
[147.625548] Starting dynamic subtest: pipe-B
[148.750296] Dynamic subtest pipe-B: SUCCESS (1.133s)
[148.759079] Starting dynamic subtest: pipe-C
[149.858532] Dynamic subtest pipe-C: SUCCESS (1.107s)
[149.867504] Starting dynamic subtest: pipe-D
[150.990277] Dynamic subtest pipe-D: SUCCESS (1.131s)
[150.992592] Subtest planes-upscale-factor-0-25: SUCCESS (3.439s)
[152.167241] [021/131] (870s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[152.272666] Starting subtest: fbcpsr-rgb101010-draw-render
[159.034827] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.765s)
[159.160213] [022/131] (863s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[159.287378] Starting subtest: 2x-long-flip-vs-cursor-atomic
[159.291934] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[159.432884] [023/131] (863s left) gem_exec_balancer (bonded-sync)
[159.489388] Starting subtest: bonded-sync
[159.494108] Subtest bonded-sync: SKIP (0.000s)
[159.795261] [024/131] (863s left) kms_feature_discovery (chamelium)
[159.895204] Starting subtest: chamelium
[159.899750] Subtest chamelium: SKIP (0.000s)
[159.966413] [025/131] (863s left) kms_pm_backlight (fade)
[160.066647] Starting subtest: fade
[160.120998] Starting dynamic subtest: eDP-1
[163.128860] Dynamic subtest eDP-1: SUCCESS (3.009s)
[163.131233] Subtest fade: SUCCESS (3.064s)
[163.922486] [026/131] (859s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[164.027096] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[164.029508] Starting dynamic subtest: pipe-A-eDP-1
[164.052193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.062589] Starting dynamic subtest: pipe-B-eDP-1
[164.085445] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.093860] Starting dynamic subtest: pipe-C-eDP-1
[164.115349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.123081] Starting dynamic subtest: pipe-D-eDP-1
[164.145157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.149532] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[166.291171] [027/131] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[166.401092] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[166.405442] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[166.495508] [028/131] (856s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[166.604164] Starting subtest: fbc-psr2-sprite-mmap-gtt
[166.606405] Starting dynamic subtest: eDP-1
[166.610267] Dynamic subtest eDP-1: SKIP (0.000s)
[166.614175] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[166.677398] [029/131] (856s left) gem_mmap (bad-size)
[166.724300] Subtest bad-size: SKIP (0.000s)
[166.779745] [030/131] (856s left) perf_pmu (semaphore-wait)
[166.821368] Starting subtest: semaphore-wait
[166.823675] Starting dynamic subtest: rcs0
[167.334391] Dynamic subtest rcs0: SUCCESS (0.512s)
[167.346709] Starting dynamic subtest: bcs0
[167.846834] Dynamic subtest bcs0: SUCCESS (0.510s)
[167.858418] Starting dynamic subtest: vcs0
[168.362381] Dynamic subtest vcs0: SUCCESS (0.512s)
[168.376719] Starting dynamic subtest: vcs1
[168.875531] Dynamic subtest vcs1: SUCCESS (0.510s)
[168.887030] Starting dynamic subtest: vecs0
[169.389528] Dynamic subtest vecs0: SUCCESS (0.511s)
[169.400959] Starting dynamic subtest: ccs0
[169.905367] Dynamic subtest ccs0: SUCCESS (0.512s)
[169.908160] Subtest semaphore-wait: SUCCESS (3.086s)
[171.333329] [031/131] (851s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[171.397565] Starting subtest: single-wait-for-submit-available-submitted
[171.399915] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[171.506025] [032/131] (851s left) perf_pmu (busy-accuracy-2)
[171.546950] Starting subtest: busy-accuracy-2
[171.549236] Starting dynamic subtest: rcs0
[174.593075] Dynamic subtest rcs0: SUCCESS (3.045s)
[174.603622] Starting dynamic subtest: bcs0
[177.653027] Dynamic subtest bcs0: SUCCESS (3.057s)
[177.663673] Starting dynamic subtest: vcs0
[180.701835] Dynamic subtest vcs0: SUCCESS (3.046s)
[180.713535] Starting dynamic subtest: vcs1
[183.751029] Dynamic subtest vcs1: SUCCESS (3.046s)
[183.761606] Starting dynamic subtest: vecs0
[186.797396] Dynamic subtest vecs0: SUCCESS (3.043s)
[186.807848] Starting dynamic subtest: ccs0
[189.859817] Dynamic subtest ccs0: SUCCESS (3.060s)
[189.862623] Subtest busy-accuracy-2: SUCCESS (18.313s)
[189.974255] [033/131] (833s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[190.097843] Starting subtest: flip-vs-cursor-toggle
[199.156907] Subtest flip-vs-cursor-toggle: SUCCESS (9.057s)
[200.018728] [034/131] (823s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[200.121968] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[200.125973] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[200.196671] [035/131] (823s left) gem_bad_reloc (negative-reloc-lut)
[200.256205] Subtest negative-reloc-lut: SKIP (0.000s)
[200.322996] [036/131] (823s left) gem_exec_reloc (basic-gtt-active)
[200.375026] Subtest basic-gtt-active: SKIP (0.000s)
[200.434615] [037/131] (823s left) syncobj_wait (multi-wait-all-signaled)
[200.484314] Starting subtest: multi-wait-all-signaled
[200.486213] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[200.571189] [038/131] (822s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[200.662210] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[200.664513] Starting dynamic subtest: pipe-A-eDP-1
[200.686699] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[200.697581] Starting dynamic subtest: pipe-B-eDP-1
[200.718461] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[200.726636] Starting dynamic subtest: pipe-C-eDP-1
[200.747543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[200.756053] Starting dynamic subtest: pipe-D-eDP-1
[200.777043] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[200.780915] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[202.967170] [039/131] (820s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[203.064304] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[203.068448] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[203.133585] [040/131] (820s left) perf (non-system-wide-paranoid)
[203.225174] Starting subtest: non-system-wide-paranoid
[203.255696] Subtest non-system-wide-paranoid: SUCCESS (0.031s)
[203.297896] [041/131] (820s left) gem_exec_params (larger-than-life-batch)
[203.349548] Starting subtest: larger-than-life-batch
[205.685710] Subtest larger-than-life-batch: SUCCESS (2.335s)
[206.331258] [042/131] (817s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[206.486815] Starting subtest: basic-max-pipe-crc-check
[206.491140] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[206.532882] [043/131] (817s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[206.652604] Starting subtest: basic-flip-after-cursor-varying-size
[207.610811] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.958s)
[208.491621] [044/131] (815s left) gem_pxp (verify-pxp-stale-ctx-execution)
[208.613215] Starting subtest: verify-pxp-stale-ctx-execution
[209.673949] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[209.797404] [045/131] (813s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[209.897657] Starting subtest: y-tiled-16bpp-rotate-0
[209.902195] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[209.992274] [046/131] (813s left) gem_ctx_engines (none)
[210.070537] Starting subtest: none
[210.072498] Subtest none: SUCCESS (0.002s)
[210.253393] [047/131] (813s left) gen9_exec_parse (bb-large)
[210.331327] Subtest bb-large: SKIP (0.000s)
[210.431503] [048/131] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[210.541844] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[210.546077] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[210.648704] [049/131] (813s left) vgem_basic (second-client)
[210.793974] Starting subtest: second-client
[210.815751] Subtest second-client: SUCCESS (0.022s)
[210.870915] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[210.874637] [050/131] (813s left) kms_psr (fbc-pr-basic)
[210.978182] Starting subtest: fbc-pr-basic
[210.982539] Subtest fbc-pr-basic: SKIP (0.000s)
[211.067124] [051/131] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[211.175055] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[234.205637] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.033s)
[234.352516] [052/131] (789s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[234.459525] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[238.862511] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.406s)
[240.029500] [053/131] (784s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[240.125301] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[240.129259] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[240.207021] [054/131] (783s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[240.301851] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[240.306369] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[240.399784] [055/131] (783s left) kms_psr (fbc-pr-sprite-blt)
[240.493715] Starting subtest: fbc-pr-sprite-blt
[240.497748] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[240.564182] [056/131] (783s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[240.662932] Starting subtest: yf-tiled-16bpp-rotate-180
[240.667442] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[240.759964] [057/131] (783s left) kms_content_protection (srm)
[240.906443] Starting subtest: srm
[240.913945] Subtest srm: SKIP (0.003s)
[241.034913] [058/131] (783s left) core_hotunplug (unbind-rebind)
[241.123467] Starting subtest: unbind-rebind
[247.037963] Subtest unbind-rebind: SUCCESS (5.914s)
[247.077237] [059/131] (777s left) i915_pm_rpm (gem-pread)
[248.634734] Starting subtest: gem-pread
[250.734441] Subtest gem-pread: SUCCESS (2.102s)
[250.825252] [060/131] (773s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[251.070569] Starting subtest: cursor-rapid-movement-256x85
[251.129437] Subtest cursor-rapid-movement-256x85: SKIP (0.054s)
[251.290061] [061/131] (773s left) i915_hangman (error-state-basic)
[251.366672] Starting subtest: error-state-basic
[251.464408] Subtest error-state-basic: SUCCESS (0.098s)
[251.553897] [062/131] (772s left) gem_exec_whisper (basic-contexts-all)
[251.609632] Starting subtest: basic-contexts-all
[262.733855] Subtest basic-contexts-all: SUCCESS (11.120s)
[262.939193] [063/131] (761s left) syncobj_wait (reset-multiple-signaled)
[262.998485] Starting subtest: reset-multiple-signaled
[263.000814] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[263.101560] [064/131] (761s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[263.196110] Starting subtest: primary-y-tiled-reflect-x-180
[263.275466] Subtest primary-y-tiled-reflect-x-180: SKIP (0.080s)
[263.382103] [065/131] (761s left) syncobj_timeline (invalid-query-zero-handles)
[263.443733] Starting subtest: invalid-query-zero-handles
[263.446255] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[263.554629] [066/131] (761s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[263.643107] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[263.645366] Starting dynamic subtest: pipe-A-eDP-1
[263.710603] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[263.722405] Starting dynamic subtest: pipe-B-eDP-1
[263.779773] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[263.791077] Starting dynamic subtest: pipe-C-eDP-1
[263.848984] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[263.860405] Starting dynamic subtest: pipe-D-eDP-1
[263.908695] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[263.912319] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[265.942991] [067/131] (758s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[265.991058] Starting subtest: multi-wait-for-submit-available-submitted
[265.993340] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[266.087241] [068/131] (758s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[266.180034] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[266.182370] Starting dynamic subtest: pipe-A-default-mode
[267.303601] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[267.307633] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.123s)
[267.451641] [069/131] (757s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[267.577597] Starting subtest: 2x-long-cursor-vs-flip-atomic
[267.582201] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[267.735976] [070/131] (757s left) gem_spin_batch (resubmit-new-all)
[267.790486] Starting subtest: resubmit-new-all
[267.792914] Starting dynamic subtest: rcs0
[267.805708] Dynamic subtest rcs0: SUCCESS (0.014s)
[267.820677] Starting dynamic subtest: bcs0
[267.822593] Dynamic subtest bcs0: SUCCESS (0.011s)
[267.832893] Starting dynamic subtest: vcs0
[267.835098] Dynamic subtest vcs0: SUCCESS (0.009s)
[267.845170] Starting dynamic subtest: vcs1
[267.847443] Dynamic subtest vcs1: SUCCESS (0.009s)
[267.857447] Starting dynamic subtest: vecs0
[267.859370] Dynamic subtest vecs0: SUCCESS (0.008s)
[267.868988] Starting dynamic subtest: ccs0
[267.870905] Dynamic subtest ccs0: SUCCESS (0.007s)
[267.872831] Subtest resubmit-new-all: SUCCESS (0.063s)
[269.351939] [071/131] (755s left) gem_exec_fence (syncobj-timeline-chain-engines)
[269.929865] Starting subtest: syncobj-timeline-chain-engines
[270.023529] Subtest syncobj-timeline-chain-engines: SUCCESS (0.096s)
[271.373836] [072/131] (753s left) kms_rotation_crc (sprite-rotation-90)
[271.478964] Starting subtest: sprite-rotation-90
[271.483423] Subtest sprite-rotation-90: SKIP (0.001s)
[271.564680] [073/131] (753s left) kms_chamelium_color (ctm-limited-range)
[271.662318] Subtest ctm-limited-range: SKIP (0.000s)
[271.710806] [074/131] (753s left) kms_psr (psr2-cursor-mmap-cpu)
[271.808870] Starting subtest: psr2-cursor-mmap-cpu
[271.811137] Starting dynamic subtest: eDP-1
[273.539917] Dynamic subtest eDP-1: SUCCESS (1.732s)
[273.542547] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.733s)
[274.347758] [075/131] (750s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[274.399933] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[274.506508] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[274.596634] [076/131] (750s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[274.720919] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[274.870612] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.152s)
[274.993187] [077/131] (750s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[275.090468] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[276.102878] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[276.228166] [078/131] (748s left) gem_partial_pwrite_pread (write-uncached)
[276.290146] Subtest write-uncached: SKIP (0.000s)
[276.364102] [079/131] (748s left) kms_async_flips (crc-atomic)
[276.458459] Starting subtest: crc-atomic
[276.844738] Starting dynamic subtest: pipe-A-eDP-1
[279.756064] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.910s)
[280.135318] Starting dynamic subtest: pipe-B-eDP-1
[283.094063] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.964s)
[283.454914] Starting dynamic subtest: pipe-C-eDP-1
[286.395434] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.950s)
[286.777723] Starting dynamic subtest: pipe-D-eDP-1
[289.647304] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.882s)
[289.649717] Subtest crc-atomic: SUCCESS (13.189s)
[290.800349] [080/131] (734s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[290.901341] Starting subtest: fbc-shrfb-scaledprimary
[293.866570] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.968s)
[295.009924] [081/131] (730s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[295.136183] Starting subtest: cursor-vs-flip-legacy
[324.930195] Subtest cursor-vs-flip-legacy: SUCCESS (29.792s)
[325.731557] [082/131] (699s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[325.846037] Starting subtest: x-tiled-16bpp-rotate-180
[327.135703] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.290s)
[327.283972] [083/131] (698s left) gem_userptr_blits (sync-unmap-after-close)
[327.367080] Starting subtest: sync-unmap-after-close
[327.375883] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[327.487592] [084/131] (697s left) kms_addfb_basic (bad-pitch-0)
[327.552070] Starting subtest: bad-pitch-0
[327.553979] Subtest bad-pitch-0: SUCCESS (0.000s)
[327.711549] [085/131] (697s left) gem_exec_schedule (preemptive-hang)
[327.894452] Starting subtest: preemptive-hang
[327.896996] Starting dynamic subtest: rcs0
[337.385891] Dynamic subtest rcs0: SUCCESS (9.488s)
[337.409044] Starting dynamic subtest: bcs0
[346.472414] Dynamic subtest bcs0: SUCCESS (9.088s)
[346.484778] Starting dynamic subtest: vcs0
[355.431321] Dynamic subtest vcs0: SUCCESS (8.954s)
[355.443411] Starting dynamic subtest: vcs1
[364.389061] Dynamic subtest vcs1: SUCCESS (8.960s)
[364.398891] Starting dynamic subtest: vecs0
[373.407492] Dynamic subtest vecs0: SUCCESS (9.015s)
[373.420571] Starting dynamic subtest: ccs0
[382.441547] Dynamic subtest ccs0: SUCCESS (9.031s)
[382.443967] Subtest preemptive-hang: SUCCESS (54.545s)
[382.685459] [086/131] (642s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[382.807244] Starting subtest: cursorB-vs-flipB-toggle
[382.811605] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[382.954844] [087/131] (642s left) gem_huc_copy (huc-copy)
[383.012451] Starting subtest: huc-copy
[383.017893] Subtest huc-copy: SUCCESS (0.003s)
[383.155368] [088/131] (642s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[383.247314] Starting subtest: fbc-rgb101010-draw-mmap-wc
[387.836982] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.592s)
[389.029051] [089/131] (636s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[389.138769] Starting subtest: cursor-tearing-framebuffer-change
[389.141022] Starting dynamic subtest: pipe-A-eDP-1
[389.708590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[389.718655] Starting dynamic subtest: pipe-D-eDP-1
[390.965931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s)
[390.967830] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.824s)
[391.794692] [090/131] (633s left) kms_fence_pin_leak
[391.957300] [091/131] (633s left) kms_getfb (getfb-repeated-different-handles)
[392.049160] Starting subtest: getfb-repeated-different-handles
[392.051463] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[392.146422] [092/131] (633s left) kms_lease (atomic-implicit-crtc)
[392.235290] Starting subtest: atomic-implicit-crtc
[392.237789] Starting dynamic subtest: pipe-A-eDP-1
[392.249586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[392.264409] Starting dynamic subtest: pipe-B-eDP-1
[392.275378] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[392.286057] Starting dynamic subtest: pipe-C-eDP-1
[392.296758] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[392.306910] Starting dynamic subtest: pipe-D-eDP-1
[392.317214] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[392.319319] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[392.392815] [093/131] (633s left) kms_dp_linktrain_fallback (dsc-fallback)
[392.496924] Starting subtest: dsc-fallback
[392.503313] Subtest dsc-fallback: SKIP (0.000s)
[392.572284] [094/131] (633s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[392.624241] Starting subtest: wait-all-for-submit-delayed-submit
[392.726473] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[392.818622] [095/131] (633s left) kms_plane (pixel-format-yf-tiled-modifier)
[392.908265] Starting subtest: pixel-format-yf-tiled-modifier
[392.912277] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[392.998319] [096/131] (632s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[393.105440] Starting subtest: 2x-plain-flip-ts-check-interruptible
[393.117671] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[393.209998] [097/131] (632s left) gem_softpin (softpin)
[393.273593] Starting subtest: softpin
[425.610206] Subtest softpin: SUCCESS (32.330s)
[425.735134] [098/131] (600s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[425.804219] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[425.877190] [099/131] (600s left) kms_selftest (drm_format)
[425.923820] Starting subtest: drm_format
[425.971665] Starting dynamic subtest: drm_test_format_block_width_invalid
[426.061114] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.089s)
[426.071386] Starting dynamic subtest: drm_test_format_block_width_one_plane
[426.145537] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.084s)
[426.155547] Starting dynamic subtest: drm_test_format_block_width_two_plane
[426.243422] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.098s)
[426.253465] Starting dynamic subtest: drm_test_format_block_width_three_plane
[426.337721] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.093s)
[426.347966] Starting dynamic subtest: drm_test_format_block_width_tiled
[426.446136] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.108s)
[426.457522] Starting dynamic subtest: drm_test_format_block_height_invalid
[426.564208] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.116s)
[426.575822] Starting dynamic subtest: drm_test_format_block_height_one_plane
[426.660215] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.097s)
[426.670151] Starting dynamic subtest: drm_test_format_block_height_two_plane
[426.751275] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.090s)
[426.762598] Starting dynamic subtest: drm_test_format_block_height_three_plane
[426.846316] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.094s)
[426.857676] Starting dynamic subtest: drm_test_format_block_height_tiled
[426.936316] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.090s)
[426.947821] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[427.037372] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.099s)
[427.048882] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[427.125108] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.087s)
[427.136887] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[427.203078] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.075s)
[427.213395] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[427.292968] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.090s)
[427.304322] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[427.397070] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.102s)
[427.408603] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[427.497315] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.100s)
[427.509105] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[427.581997] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.083s)
[427.593101] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[427.674376] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.092s)
[427.676262] Subtest drm_format: SUCCESS (1.752s)
[427.833051] [100/131] (598s left) kms_big_fb (yf-tiled-addfb)
[427.932729] Starting subtest: yf-tiled-addfb
[427.936599] Subtest yf-tiled-addfb: SKIP (0.000s)
[428.030160] [101/131] (598s left) gem_eio (in-flight-immediate)
[428.267065] Starting subtest: in-flight-immediate
[437.223578] Subtest in-flight-immediate: SUCCESS (8.955s)
[437.391738] [102/131] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[437.501407] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[437.505688] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[437.602616] [103/131] (588s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[437.696751] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[444.284046] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.591s)
[444.416773] [104/131] (581s left) kms_psr (psr-sprite-plane-onoff)
[444.528141] Starting subtest: psr-sprite-plane-onoff
[444.530402] Starting dynamic subtest: eDP-1
[446.334038] Dynamic subtest eDP-1: SUCCESS (1.806s)
[446.336701] Subtest psr-sprite-plane-onoff: SUCCESS (1.807s)
[447.165735] [105/131] (579s left) kms_chamelium_hpd (vga-hpd-fast)
[447.561511] Subtest vga-hpd-fast: SKIP (0.000s)
[448.370485] [106/131] (578s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[448.463814] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[448.466144] Starting dynamic subtest: pipe-A-eDP-1
[448.487436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.499708] Starting dynamic subtest: pipe-B-eDP-1
[448.520149] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.529706] Starting dynamic subtest: pipe-C-eDP-1
[448.550315] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.560143] Starting dynamic subtest: pipe-D-eDP-1
[448.581683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.586020] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[450.737486] [107/131] (575s left) kms_big_fb (linear-32bpp-rotate-90)
[450.838691] Starting subtest: linear-32bpp-rotate-90
[450.858018] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[450.967325] [108/131] (575s left) perf (buffer-fill)
[451.110348] Starting subtest: buffer-fill
[451.112237] Starting dynamic subtest: 0-rcs0
[453.355631] Dynamic subtest 0-rcs0: SUCCESS (2.243s)
[453.367601] Starting dynamic subtest: 1-vcs1
[457.787375] Dynamic subtest 1-vcs1: SUCCESS (4.432s)
[457.790080] Subtest buffer-fill: SUCCESS (6.678s)
[457.840309] [109/131] (568s left) api_intel_bb (object-noreloc-keep-cache-simple)
[457.891154] Starting subtest: object-noreloc-keep-cache-simple
[457.893906] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[458.024381] [110/131] (568s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[458.155581] Starting subtest: short-flip-before-cursor-atomic-transitions
[459.116054] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.959s)
[459.965274] [111/131] (566s left) kms_addfb_basic (invalid-get-prop)
[460.016974] Starting subtest: invalid-get-prop
[460.019204] Subtest invalid-get-prop: SUCCESS (0.000s)
[460.154222] [112/131] (566s left) i915_selftest (mock)
[461.824622] Starting subtest: mock
[461.827715] Starting dynamic subtest: sanitycheck
[462.537085] Dynamic subtest sanitycheck: SUCCESS (0.712s)
[462.547267] Starting dynamic subtest: shmem
[463.302216] Dynamic subtest shmem: SUCCESS (0.763s)
[463.312561] Starting dynamic subtest: fence
[471.406042] Dynamic subtest fence: SUCCESS (8.101s)
[471.416644] Starting dynamic subtest: scatterlist
[473.094082] Dynamic subtest scatterlist: SUCCESS (1.686s)
[473.103976] Starting dynamic subtest: syncmap
[476.316403] Dynamic subtest syncmap: SUCCESS (3.220s)
[476.326555] Starting dynamic subtest: uncore
[477.001021] Dynamic subtest uncore: SUCCESS (0.684s)
[477.010996] Starting dynamic subtest: ring
[477.682202] Dynamic subtest ring: SUCCESS (0.679s)
[477.692822] Starting dynamic subtest: engine
[478.396091] Dynamic subtest engine: SUCCESS (0.712s)
[478.406231] Starting dynamic subtest: timelines
[482.253767] Dynamic subtest timelines: SUCCESS (3.854s)
[482.263616] Starting dynamic subtest: requests
[485.776965] Dynamic subtest requests: SUCCESS (3.522s)
[485.792978] Starting dynamic subtest: objects
[486.538194] Dynamic subtest objects: SUCCESS (0.760s)
[486.548505] Starting dynamic subtest: phys
[487.321201] Dynamic subtest phys: SUCCESS (0.781s)
[487.330175] Starting dynamic subtest: dmabuf
[488.094963] Dynamic subtest dmabuf: SUCCESS (0.772s)
[488.105637] Starting dynamic subtest: vma
[493.921185] Dynamic subtest vma: SUCCESS (5.824s)
[493.931655] Starting dynamic subtest: evict
[495.335998] Dynamic subtest evict: SUCCESS (1.413s)
[495.347199] Starting dynamic subtest: gtt
[498.648232] Dynamic subtest gtt: SUCCESS (3.311s)
[498.658144] Starting dynamic subtest: hugepages
[499.531035] Dynamic subtest hugepages: SUCCESS (0.881s)
[499.541028] Starting dynamic subtest: memory_region
[502.059479] Dynamic subtest memory_region: SUCCESS (2.527s)
[502.061897] Subtest mock: SUCCESS (40.234s)
[502.090957] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[502.091737] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[502.094715] [113/131] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[503.683298] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[503.687230] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[503.764132] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[503.765392] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[503.769069] [114/131] (522s left) gem_mmap_gtt (flink-race)
[503.827199] Subtest flink-race: SKIP (0.000s)
[503.903456] [115/131] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[504.002800] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[508.270706] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.271s)
[509.411315] [116/131] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[509.502323] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[517.021925] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.523s)
[517.150309] [117/131] (509s left) perf_pmu (enable-race)
[517.195686] Starting subtest: enable-race
[517.197915] Starting dynamic subtest: rcs0
[529.967968] Dynamic subtest rcs0: SUCCESS (12.773s)
[529.982060] Starting dynamic subtest: bcs0
[542.712143] Dynamic subtest bcs0: SUCCESS (12.741s)
[542.722467] Starting dynamic subtest: vcs0
[558.270925] Dynamic subtest vcs0: SUCCESS (15.554s)
[558.283049] Starting dynamic subtest: vcs1
[574.270097] Dynamic subtest vcs1: SUCCESS (15.995s)
[574.281138] Starting dynamic subtest: vecs0
[590.269805] Dynamic subtest vecs0: SUCCESS (15.998s)
[590.281194] Starting dynamic subtest: ccs0
[603.013933] Dynamic subtest ccs0: SUCCESS (12.742s)
[603.016476] Subtest enable-race: SUCCESS (85.817s)
[603.126182] [118/131] (423s left) gem_readwrite (read-write)
[603.192603] Subtest read-write: SKIP (0.000s)
[603.251786] [119/131] (423s left) perf_pmu (all-busy-check-all)
[603.291334] Starting subtest: all-busy-check-all
[605.310796] Subtest all-busy-check-all: SUCCESS (2.020s)
[605.401961] [120/131] (421s left) kms_busy (extended-modeset-hang-oldfb)
[605.515926] Starting subtest: extended-modeset-hang-oldfb
[605.518130] Starting dynamic subtest: pipe-A
[617.237305] Dynamic subtest pipe-A: SUCCESS (11.719s)
[617.246500] Starting dynamic subtest: pipe-D
[629.524261] Dynamic subtest pipe-D: SUCCESS (12.285s)
[629.526384] Subtest extended-modeset-hang-oldfb: SUCCESS (24.009s)
[630.403482] [121/131] (396s left) gem_softpin (overlap)
[630.465697] Starting subtest: overlap
[631.370938] Subtest overlap: SUCCESS (0.904s)
[631.482593] [122/131] (395s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[631.579810] Starting subtest: basic-modeset-with-all-modifiers-formats
[631.954211] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[632.707107] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.753s)
[632.716636] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[632.728692] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.019s)
[632.737410] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[632.750990] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.020s)
[632.760329] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[632.906825] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.154s)
[632.916017] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[632.928505] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[632.937842] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[632.951168] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[632.964714] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[632.973266] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.020s)
[632.985729] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[632.995437] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[633.007172] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[633.017427] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.020s)
[633.026634] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[633.039848] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[633.048729] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[633.062148] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[633.071058] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[633.084422] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[633.093696] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[633.239955] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[633.250037] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[633.262132] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[633.271085] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[633.284295] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[633.293298] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[633.306605] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[633.315892] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[633.328560] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[633.337668] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[633.351064] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[633.360513] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[633.373256] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[633.382898] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[633.395452] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[633.404315] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[633.417718] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[633.426864] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[633.585027] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[633.597733] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[633.606984] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[633.616888] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[633.628896] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[633.637568] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[633.651062] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[633.665249] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[633.673428] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[633.682220] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[633.695490] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[633.704299] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[633.717786] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[633.726508] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[633.739840] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[633.748508] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[633.761904] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[634.145136] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.567s)
[634.978937] [123/131] (392s left) gem_exec_basic (basic)
[635.048417] Starting subtest: basic
[635.050724] Starting dynamic subtest: rcs0-smem
[635.052961] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[635.063080] Starting dynamic subtest: bcs0-smem
[635.065217] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[635.073763] Starting dynamic subtest: vcs0-smem
[635.075654] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[635.084374] Starting dynamic subtest: vcs1-smem
[635.086287] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[635.094858] Starting dynamic subtest: vecs0-smem
[635.096810] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[635.105272] Starting dynamic subtest: ccs0-smem
[635.107162] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[635.109060] Subtest basic: SUCCESS (0.014s)
[636.338732] [124/131] (390s left) api_intel_bb (blit-reloc-purge-cache)
[636.397393] Starting subtest: blit-reloc-purge-cache
[636.401594] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[636.525517] [125/131] (390s left) kms_psr (pr-cursor-mmap-gtt)
[636.611109] Starting subtest: pr-cursor-mmap-gtt
[636.615351] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[636.696862] [126/131] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[636.802539] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[636.806672] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[636.909387] [127/131] (390s left) i915_drm_fdinfo (memory-info-shared)
[636.952767] Starting subtest: memory-info-shared
[636.955064] Starting dynamic subtest: smem0
[636.995519] Dynamic subtest smem0: SUCCESS (0.043s)
[636.997897] Subtest memory-info-shared: SUCCESS (0.043s)
[637.072422] [128/131] (390s left) gem_ctx_isolation (dirty-create)
[637.135284] Starting subtest: dirty-create
[637.137758] Starting dynamic subtest: rcs0
[637.337158] Dynamic subtest rcs0: SUCCESS (0.202s)
[637.348262] Starting dynamic subtest: bcs0
[637.547686] Dynamic subtest bcs0: SUCCESS (0.210s)
[637.557591] Starting dynamic subtest: vcs0
[637.746864] Dynamic subtest vcs0: SUCCESS (0.198s)
[637.755981] Starting dynamic subtest: vcs1
[639.484142] Dynamic subtest vcs1: SUCCESS (1.736s)
[639.496072] Starting dynamic subtest: vecs0
[641.475368] Dynamic subtest vecs0: SUCCESS (1.990s)
[641.486578] Starting dynamic subtest: ccs0
[643.474522] Dynamic subtest ccs0: SUCCESS (1.998s)
[643.476965] Subtest dirty-create: SUCCESS (6.340s)
[643.720911] [129/131] (383s left) gem_watchdog (default-virtual)
[643.798055] Starting subtest: default-virtual
[650.079740] Subtest default-virtual: SUCCESS (6.291s)
[650.168837] [130/131] (377s left) kms_joiner (invalid-modeset-big-joiner)
[650.287765] Starting subtest: invalid-modeset-big-joiner
[650.292208] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[650.357981] [131/131] (377s left) syncobj_timeline (wait-for-submit-complex)
[650.421947] Starting subtest: wait-for-submit-complex
[650.483700] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[650.572637] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_bad_destroy
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_color
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: gem_ctx_persistence
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_pread
results: parsing output: 14/ for test: gem_ctx_bad_destroy
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_feature_discovery
results: parsing output: 24/ for test: kms_pm_backlight
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_mmap
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: gem_bad_reloc
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: kms_multipipe_modeset
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: core_hotunplug
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: i915_hangman
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_chamelium_color
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_huc_copy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_fence_pin_leak
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: kms_dp_linktrain_fallback
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: i915_selftest
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: gem_readwrite
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: gem_exec_basic
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: gem_watchdog
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: syncobj_timeline
Done.