[71.870954] Initializing watchdogs
[71.871009]   /dev/watchdog0
[71.885248] [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]
[71.889623] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.891889] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.895294] [001/133] (960s left) kms_psr (psr2-primary-mmap-gtt)
[72.018606] Starting subtest: psr2-primary-mmap-gtt
[72.020894] Starting dynamic subtest: eDP-1
[73.499361] Dynamic subtest eDP-1: SKIP (1.480s)
[73.504291] Subtest psr2-primary-mmap-gtt: SKIP (1.481s)
[73.631314] [002/133] (958s left) i915_selftest (mock)
[76.890776] Starting subtest: mock
[76.893636] Starting dynamic subtest: sanitycheck
[77.579440] Dynamic subtest sanitycheck: SUCCESS (0.690s)
[77.588776] Starting dynamic subtest: shmem
[78.258445] Dynamic subtest shmem: SUCCESS (0.678s)
[78.269260] Starting dynamic subtest: fence
[86.381898] Dynamic subtest fence: SUCCESS (8.124s)
[86.391371] Starting dynamic subtest: scatterlist
[88.059939] Dynamic subtest scatterlist: SUCCESS (1.677s)
[88.069290] Starting dynamic subtest: syncmap
[91.214972] Dynamic subtest syncmap: SUCCESS (3.154s)
[91.225280] Starting dynamic subtest: uncore
[91.914308] Dynamic subtest uncore: SUCCESS (0.698s)
[91.923489] Starting dynamic subtest: ring
[92.566245] Dynamic subtest ring: SUCCESS (0.652s)
[92.575654] Starting dynamic subtest: engine
[93.261384] Dynamic subtest engine: SUCCESS (0.694s)
[93.271219] Starting dynamic subtest: timelines
[96.967209] Dynamic subtest timelines: SUCCESS (3.704s)
[96.976890] Starting dynamic subtest: requests
[100.899048] Dynamic subtest requests: SUCCESS (3.931s)
[100.908392] Starting dynamic subtest: objects
[101.707893] Dynamic subtest objects: SUCCESS (0.809s)
[101.716882] Starting dynamic subtest: phys
[102.510312] Dynamic subtest phys: SUCCESS (0.802s)
[102.518851] Starting dynamic subtest: dmabuf
[103.273158] Dynamic subtest dmabuf: SUCCESS (0.762s)
[103.284840] Starting dynamic subtest: vma
[108.902074] Dynamic subtest vma: SUCCESS (5.627s)
[108.910631] Starting dynamic subtest: evict
[110.298046] Dynamic subtest evict: SUCCESS (1.395s)
[110.306575] Starting dynamic subtest: gtt
[113.613667] Dynamic subtest gtt: SUCCESS (3.315s)
[113.622130] Starting dynamic subtest: hugepages
[114.510269] Dynamic subtest hugepages: SUCCESS (0.897s)
[114.517699] Starting dynamic subtest: memory_region
[116.964751] Dynamic subtest memory_region: SUCCESS (2.454s)
[116.967262] Subtest mock: SUCCESS (40.078s)
[116.994579] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[116.997458] [003/133] (915s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[118.487759] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[118.594018] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[118.642602] [FACT syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[118.646070] [004/133] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[118.762072] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[125.618049] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.860s)
[125.766116] [005/133] (906s left) syncobj_wait (multi-wait-for-submit-submitted)
[125.822983] Starting subtest: multi-wait-for-submit-submitted
[125.931886] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[126.015813] [006/133] (906s left) kms_pm_rpm (modeset-pc8-residency-stress)
[127.575576] Starting subtest: modeset-pc8-residency-stress
[127.580644] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[128.313911] [007/133] (904s left) gem_userptr_blits (sync-unmap)
[128.385140] Starting subtest: sync-unmap
[128.397647] Subtest sync-unmap: SUCCESS (0.014s)
[128.539614] [008/133] (904s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[128.588723] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[128.591141] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[128.687661] [009/133] (904s left) kms_plane_scaling (planes-upscale-factor-0-25)
[128.771865] Starting subtest: planes-upscale-factor-0-25
[128.774257] Starting dynamic subtest: pipe-A
[128.833533] Dynamic subtest pipe-A: SUCCESS (0.063s)
[128.843229] Starting dynamic subtest: pipe-B
[130.020752] Dynamic subtest pipe-B: SUCCESS (1.187s)
[130.030204] Starting dynamic subtest: pipe-C
[131.134702] Dynamic subtest pipe-C: SUCCESS (1.113s)
[131.142706] Starting dynamic subtest: pipe-D
[132.269226] Dynamic subtest pipe-D: SUCCESS (1.134s)
[132.271503] Subtest planes-upscale-factor-0-25: SUCCESS (3.500s)
[133.412417] [010/133] (899s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[133.508801] Starting subtest: fbc-psr-sprite-mmap-cpu
[133.511155] Starting dynamic subtest: eDP-1
[133.515758] Dynamic subtest eDP-1: SKIP (0.000s)
[133.520224] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[133.576731] [011/133] (899s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[133.677672] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[133.682245] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[133.782955] [012/133] (899s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[133.844824] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[133.948487] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[134.026663] [013/133] (898s left) kms_pm_dc (dc5-psr)
[135.126380] Starting subtest: dc5-psr
[138.010260] Subtest dc5-psr: SUCCESS (2.884s)
[138.845782] [014/133] (894s left) gem_exec_fence (submit3)
[139.023350] Starting subtest: submit3
[139.028583] Subtest submit3: SKIP (0.000s)
[140.383624] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[140.386678] [015/133] (892s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[140.438379] Starting subtest: invalid-multi-wait-unsubmitted
[140.440688] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[140.536025] [016/133] (892s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[140.639205] Starting subtest: x-tiled-8bpp-rotate-270
[140.661656] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[140.784995] [017/133] (892s left) gem_exec_balancer (smoke)
[140.850367] Starting subtest: smoke
[163.434301] Subtest smoke: SUCCESS (22.581s)
[165.371619] [018/133] (867s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[165.467236] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[165.471642] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[165.538159] [019/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[165.627377] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[165.631795] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[165.716758] [020/133] (867s left) kms_cursor_crc (cursor-offscreen-512x170)
[166.005811] Starting subtest: cursor-offscreen-512x170
[166.010238] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[166.160137] [021/133] (867s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[166.433995] Starting subtest: cursor-rapid-movement-512x170
[166.437973] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[166.591115] [022/133] (866s left) gen9_exec_parse (bb-start-param)
[166.651047] Subtest bb-start-param: SKIP (0.000s)
[166.719147] [023/133] (866s left) kms_psr (fbc-pr-cursor-plane-move)
[166.812382] Starting subtest: fbc-pr-cursor-plane-move
[166.815905] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[166.895482] [024/133] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[166.988974] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[166.992548] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[167.085100] [025/133] (866s left) prime_busy (hang-wait)
[167.156121] Starting subtest: hang-wait
[167.158274] Starting dynamic subtest: rcs0
[192.734794] Dynamic subtest rcs0: SUCCESS (25.575s)
[192.745143] Starting dynamic subtest: bcs0
[199.887087] Dynamic subtest bcs0: SUCCESS (7.151s)
[199.895336] Starting dynamic subtest: vcs0
[206.926438] Dynamic subtest vcs0: SUCCESS (7.037s)
[206.937248] Starting dynamic subtest: vcs1
[213.909718] Dynamic subtest vcs1: SUCCESS (6.982s)
[213.920210] Starting dynamic subtest: vecs0
[220.873812] Dynamic subtest vecs0: SUCCESS (6.966s)
[220.890311] Starting dynamic subtest: ccs0
[234.778094] Dynamic subtest ccs0: SUCCESS (13.901s)
[234.780274] Subtest hang-wait: SUCCESS (67.618s)
[234.897837] [026/133] (798s left) syncobj_timeline (reset-unsignaled)
[234.945036] Starting subtest: reset-unsignaled
[234.947335] Subtest reset-unsignaled: SUCCESS (0.000s)
[235.039067] [027/133] (798s left) gem_mmap_offset (pf-nonblock)
[235.083797] Starting subtest: pf-nonblock
[235.088916] Subtest pf-nonblock: SUCCESS (0.006s)
[235.186921] [028/133] (798s left) core_hotunplug (unbind-rebind)
[235.264188] Starting subtest: unbind-rebind
[241.182084] Subtest unbind-rebind: SUCCESS (5.917s)
[241.219702] [029/133] (792s left) gem_mmap_gtt (bad-object)
[242.278539] Subtest bad-object: SKIP (0.000s)
[242.356894] [030/133] (791s left) syncobj_timeline (invalid-query-one-illegal-handle)
[242.413871] Starting subtest: invalid-query-one-illegal-handle
[242.416059] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[242.505537] [031/133] (791s left) gem_exec_reloc (basic-gtt-read-active)
[242.561842] Subtest basic-gtt-read-active: SKIP (0.000s)
[242.635998] [032/133] (790s left) i915_drm_fdinfo (virtual-busy-idle)
[242.678670] Starting subtest: virtual-busy-idle
[242.683076] Subtest virtual-busy-idle: SKIP (0.000s)
[242.749813] [033/133] (790s left) syncobj_timeline (wait-all-delayed-signal)
[242.797730] Starting subtest: wait-all-delayed-signal
[242.904324] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[242.997960] [034/133] (790s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[243.095392] Starting subtest: y-tiled-8bpp-rotate-270
[243.099725] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[243.210184] [035/133] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[243.313330] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[243.317697] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[243.429723] [036/133] (790s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[243.531071] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[243.533378] Starting dynamic subtest: pipe-A-eDP-1
[245.713555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.185s)
[245.722564] Starting dynamic subtest: pipe-B-eDP-1
[248.100443] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.385s)
[248.110165] Starting dynamic subtest: pipe-C-eDP-1
[250.221716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.121s)
[250.231959] Starting dynamic subtest: pipe-D-eDP-1
[252.334856] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.111s)
[252.336880] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.806s)
[253.530613] [037/133] (780s left) kms_psr (pr-primary-page-flip)
[253.628704] Starting subtest: pr-primary-page-flip
[253.632943] Subtest pr-primary-page-flip: SKIP (0.000s)
[253.718310] [038/133] (780s left) kms_panel_fitting (atomic-fastset)
[253.808787] Starting subtest: atomic-fastset
[253.811082] Starting dynamic subtest: pipe-A-eDP-1
[253.948692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[253.961867] Starting dynamic subtest: pipe-B-eDP-1
[255.182402] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[255.195731] Starting dynamic subtest: pipe-C-eDP-1
[256.362964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.179s)
[256.372653] Starting dynamic subtest: pipe-D-eDP-1
[257.507793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[257.510085] Subtest atomic-fastset: SUCCESS (3.701s)
[258.757354] [039/133] (775s left) perf_pmu (busy-double-start)
[258.798303] Starting subtest: busy-double-start
[258.800610] Starting dynamic subtest: rcs0
[262.369709] Dynamic subtest rcs0: SUCCESS (3.571s)
[262.380080] Starting dynamic subtest: bcs0
[265.946203] Dynamic subtest bcs0: SUCCESS (3.574s)
[265.960330] Starting dynamic subtest: vcs0
[269.822075] Dynamic subtest vcs0: SUCCESS (3.873s)
[269.833667] Starting dynamic subtest: vcs1
[273.818042] Dynamic subtest vcs1: SUCCESS (3.994s)
[273.831179] Starting dynamic subtest: vecs0
[277.851972] Dynamic subtest vecs0: SUCCESS (4.032s)
[277.863553] Starting dynamic subtest: ccs0
[281.488679] Dynamic subtest ccs0: FAIL (3.574s)
[281.491124] Subtest busy-double-start: FAIL (22.629s)
[281.537379] [040/133] (752s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[281.644940] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[281.671687] Starting dynamic subtest: pipe-A-plane-0
[282.304911] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[282.315189] Starting dynamic subtest: pipe-A-plane-3
[282.726077] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[283.849226] Starting dynamic subtest: pipe-B-plane-0
[284.482922] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[284.494724] Starting dynamic subtest: pipe-B-plane-3
[284.883599] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[285.193393] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.550s)
[286.030967] [041/133] (747s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[286.151096] Starting subtest: cursorB-vs-flipB-atomic
[286.155685] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[286.292431] [042/133] (747s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[286.385190] Starting subtest: invalidate-primary-flip-overlay
[297.085520] Subtest invalidate-primary-flip-overlay: SUCCESS (10.702s)
[297.218320] [043/133] (736s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[297.317971] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[297.321838] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[297.432933] [044/133] (736s left) kms_busy (extended-modeset-hang-newfb)
[297.525124] Starting subtest: extended-modeset-hang-newfb
[297.527049] Starting dynamic subtest: pipe-A
[332.225867] Dynamic subtest pipe-A: SUCCESS (34.698s)
[332.237841] Starting dynamic subtest: pipe-D
[355.222177] Dynamic subtest pipe-D: SUCCESS (22.990s)
[355.224851] Subtest extended-modeset-hang-newfb: SUCCESS (57.693s)
[356.008947] [045/133] (678s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[356.115552] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[356.119699] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[356.216289] [046/133] (677s left) syncobj_basic (bad-fd-to-handle)
[356.274081] Starting subtest: bad-fd-to-handle
[356.276357] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[356.383125] [047/133] (677s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[356.471295] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[356.473609] Starting dynamic subtest: pipe-A-eDP-1
[356.498769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[356.512053] Starting dynamic subtest: pipe-B-eDP-1
[356.536213] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[356.547051] Starting dynamic subtest: pipe-C-eDP-1
[356.571388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[356.580990] Starting dynamic subtest: pipe-D-eDP-1
[356.605218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[356.609245] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[358.678753] [048/133] (675s left) i915_pm_rpm (gem-evict-pwrite)
[360.502537] Starting subtest: gem-evict-pwrite
[360.508118] Subtest gem-evict-pwrite: SKIP (0.000s)
[360.918449] [049/133] (673s left) gem_pxp (protected-raw-src-copy-not-readible)
[361.034568] Starting subtest: protected-raw-src-copy-not-readible
[361.090960] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[361.200459] [050/133] (673s left) gem_softpin (allocator-nopin)
[361.262298] Starting subtest: allocator-nopin
[361.349420] Subtest allocator-nopin: SUCCESS (0.086s)
[361.467975] [051/133] (672s left) core_auth (basic-auth)
[361.516308] Starting subtest: basic-auth
[361.518429] Subtest basic-auth: SUCCESS (0.001s)
[361.611899] [052/133] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[361.715548] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[369.024094] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.312s)
[369.153270] [053/133] (665s left) gem_exec_reloc (basic-wc-gtt-active)
[369.208355] Subtest basic-wc-gtt-active: SKIP (0.000s)
[369.285298] [054/133] (665s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[369.382313] Starting subtest: invalid-modeset-force-ultra-joiner
[369.386210] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[369.451276] [055/133] (665s left) gem_exec_whisper (basic-forked-all)
[369.518377] Starting subtest: basic-forked-all
[382.458063] Subtest basic-forked-all: SUCCESS (12.939s)
[382.649254] [056/133] (651s left) kms_flip (modeset-vs-vblank-race)
[382.736127] Starting subtest: modeset-vs-vblank-race
[382.738480] Starting dynamic subtest: A-eDP1
[387.456844] Dynamic subtest A-eDP1: SUCCESS (4.719s)
[387.468202] Starting dynamic subtest: B-eDP1
[392.213471] Dynamic subtest B-eDP1: SUCCESS (4.754s)
[392.228697] Starting dynamic subtest: C-eDP1
[396.927345] Dynamic subtest C-eDP1: SUCCESS (4.711s)
[396.939759] Starting dynamic subtest: D-eDP1
[401.378321] Dynamic subtest D-eDP1: SUCCESS (4.448s)
[401.380634] Subtest modeset-vs-vblank-race: SUCCESS (18.645s)
[402.537048] [057/133] (632s left) gem_ccs (block-copy-uncompressed)
[402.598442] Starting subtest: block-copy-uncompressed
[402.600769] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[402.621253] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[402.632962] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[402.638318] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[402.647535] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[402.655040] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[402.667411] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[402.672232] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[402.674533] Subtest block-copy-uncompressed: SUCCESS (0.074s)
[402.810683] [058/133] (631s left) gem_lmem_swapping (parallel-random)
[402.848532] Subtest parallel-random: SKIP (0.000s)
[402.893542] [059/133] (631s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[402.995988] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[402.998288] Starting dynamic subtest: pipe-A-eDP-1
[403.007369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[403.017341] Starting dynamic subtest: pipe-B-eDP-1
[403.026324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[403.035538] Starting dynamic subtest: pipe-C-eDP-1
[403.044061] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[403.052886] Starting dynamic subtest: pipe-D-eDP-1
[403.061485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[403.065550] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[405.289894] [060/133] (629s left) kms_plane (plane-panning-bottom-right-suspend)
[405.390161] Starting subtest: plane-panning-bottom-right-suspend
[405.392514] Starting dynamic subtest: pipe-A
[423.407577] Dynamic subtest pipe-A: SUCCESS (3.005s)
[423.419122] Starting dynamic subtest: pipe-B
[442.353814] Dynamic subtest pipe-B: SUCCESS (3.470s)
[442.356062] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.478s)
[443.155099] [061/133] (591s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[443.246786] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[443.250801] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[443.316960] [062/133] (591s left) syncobj_wait (invalid-wait-bad-flags)
[443.374656] Starting subtest: invalid-wait-bad-flags
[443.376772] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[443.471335] [063/133] (591s left) gem_exec_schedule (preempt)
[443.532338] Starting subtest: preempt
[443.534165] Starting dynamic subtest: rcs0
[443.548948] Dynamic subtest rcs0: SUCCESS (0.022s)
[443.561430] Starting dynamic subtest: bcs0
[443.565857] Dynamic subtest bcs0: SUCCESS (0.017s)
[443.577032] Starting dynamic subtest: vcs0
[443.587292] Dynamic subtest vcs0: SUCCESS (0.021s)
[443.598386] Starting dynamic subtest: vcs1
[443.607582] Dynamic subtest vcs1: SUCCESS (0.020s)
[443.618610] Starting dynamic subtest: vecs0
[443.630234] Dynamic subtest vecs0: SUCCESS (0.022s)
[443.641469] Starting dynamic subtest: ccs0
[443.649963] Dynamic subtest ccs0: SUCCESS (0.019s)
[443.652298] Subtest preempt: SUCCESS (0.125s)
[444.884151] [064/133] (590s left) kms_dp_link_training (uhbr-mst)
[444.968179] Starting subtest: uhbr-mst
[444.976587] Subtest uhbr-mst: SKIP (0.000s)
[445.044013] [065/133] (589s left) gem_exec_schedule (semaphore-resolve)
[445.109959] Starting subtest: semaphore-resolve
[445.142670] Subtest semaphore-resolve: SUCCESS (0.040s)
[445.513936] [066/133] (589s left) api_intel_allocator (reloc-allocator)
[445.560685] Starting subtest: reloc-allocator
[445.562452] Starting dynamic subtest: basic
[445.564715] Dynamic subtest basic: SUCCESS (0.004s)
[445.575080] Starting dynamic subtest: parallel-one
[445.576968] Dynamic subtest parallel-one: SUCCESS (0.008s)
[445.587701] Starting dynamic subtest: print
[445.589820] Dynamic subtest print: SUCCESS (0.000s)
[445.599698] Starting dynamic subtest: reuse
[445.601872] Dynamic subtest reuse: SUCCESS (0.000s)
[445.611707] Starting dynamic subtest: fork-reopen-allocator
[445.613793] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[445.615871] Subtest reloc-allocator: SUCCESS (0.026s)
[445.735219] [067/133] (589s left) core_getversion (all-cards)
[445.770445] Starting subtest: all-cards
[445.778743] Subtest all-cards: SUCCESS (0.011s)
[445.828433] [068/133] (589s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[445.926331] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[445.930693] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[446.030144] [069/133] (589s left) gem_exec_reloc (basic-cpu-read)
[446.082031] Subtest basic-cpu-read: SKIP (0.000s)
[446.194042] [070/133] (588s left) kms_big_fb (4-tiled-addfb)
[446.299818] Starting subtest: 4-tiled-addfb
[446.302086] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[446.399556] [071/133] (588s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[446.487304] Starting subtest: async-flip-with-page-flip-events-linear
[446.864977] Starting dynamic subtest: pipe-A-eDP-1
[449.594530] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.744s)
[449.969995] Starting dynamic subtest: pipe-B-eDP-1
[452.717375] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[453.084105] Starting dynamic subtest: pipe-C-eDP-1
[455.840060] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[456.208091] Starting dynamic subtest: pipe-D-eDP-1
[458.957986] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[458.960591] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.517s)
[460.147090] [072/133] (575s left) kms_content_protection (legacy)
[460.289943] Starting subtest: legacy
[460.294825] Subtest legacy: SKIP (0.000s)
[460.431134] [073/133] (574s left) i915_drm_fdinfo (busy-hang)
[460.467806] Starting subtest: busy-hang
[460.470287] Starting dynamic subtest: rcs0
[460.502751] Dynamic subtest rcs0: SKIP (0.032s)
[460.515209] Starting dynamic subtest: bcs0
[460.519642] Dynamic subtest bcs0: SKIP (0.001s)
[460.530197] Starting dynamic subtest: vcs0
[460.534888] Dynamic subtest vcs0: SKIP (0.000s)
[460.544831] Starting dynamic subtest: vcs1
[460.549188] Dynamic subtest vcs1: SKIP (0.000s)
[460.559301] Starting dynamic subtest: vecs0
[460.563759] Dynamic subtest vecs0: SKIP (0.000s)
[460.573610] Starting dynamic subtest: ccs0
[460.577918] Dynamic subtest ccs0: SKIP (0.000s)
[460.582280] Subtest busy-hang: SKIP (0.039s)
[460.623935] [074/133] (574s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[460.742973] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[492.404924] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.665s)
[493.279121] [075/133] (542s left) kms_async_flips (invalid-async-flip-atomic)
[493.377439] Starting subtest: invalid-async-flip-atomic
[493.762877] Starting dynamic subtest: pipe-A-eDP-1
[494.590703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[494.967575] Starting dynamic subtest: pipe-B-eDP-1
[495.738965] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[496.104751] Starting dynamic subtest: pipe-C-eDP-1
[496.865011] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[497.221194] Starting dynamic subtest: pipe-D-eDP-1
[497.997428] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[497.999725] Subtest invalid-async-flip-atomic: SUCCESS (4.624s)
[499.148003] [076/133] (536s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[499.239926] Starting subtest: stress-xrgb8888-yftiled
[499.244455] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[499.317957] [077/133] (536s left) kms_sequence (get-forked-busy)
[499.400231] Starting subtest: get-forked-busy
[499.402693] Starting dynamic subtest: pipe-A-eDP-1
[501.342645] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[501.353948] Starting dynamic subtest: pipe-B-eDP-1
[503.951696] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.610s)
[503.965281] Starting dynamic subtest: pipe-C-eDP-1
[506.553974] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[506.565039] Starting dynamic subtest: pipe-D-eDP-1
[509.177426] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[509.179845] Subtest get-forked-busy: SUCCESS (9.783s)
[510.077574] [078/133] (525s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[510.168036] Starting subtest: fbc-psr2-sprite-mmap-cpu
[510.169920] Starting dynamic subtest: eDP-1
[510.173852] Dynamic subtest eDP-1: SKIP (0.000s)
[510.177849] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[510.241015] [079/133] (525s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[510.333809] Starting subtest: plane-lut1d-post-ctm3x4
[510.479127] Starting dynamic subtest: pipe-A-plane-0
[510.645433] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[510.657757] Starting dynamic subtest: pipe-A-plane-1
[510.789908] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[510.800753] Starting dynamic subtest: pipe-A-plane-2
[510.978877] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[512.161902] Starting dynamic subtest: pipe-B-plane-0
[512.330587] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[512.341453] Starting dynamic subtest: pipe-B-plane-1
[512.508146] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[512.518958] Starting dynamic subtest: pipe-B-plane-2
[512.687180] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[513.887237] Starting dynamic subtest: pipe-C-plane-0
[514.021987] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[514.034744] Starting dynamic subtest: pipe-C-plane-1
[514.167111] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[514.179044] Starting dynamic subtest: pipe-C-plane-2
[514.310740] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[515.516214] Starting dynamic subtest: pipe-D-plane-0
[515.640021] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[515.653469] Starting dynamic subtest: pipe-D-plane-1
[515.787763] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[515.798597] Starting dynamic subtest: pipe-D-plane-2
[515.940290] Dynamic subtest pipe-D-plane-2: SUCCESS (0.153s)
[516.238847] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.908s)
[517.104713] [080/133] (518s left) gem_ctx_shared (q-promotion)
[517.159817] Starting subtest: Q-promotion
[517.162261] Starting dynamic subtest: rcs0
[517.274062] Dynamic subtest rcs0: SUCCESS (0.112s)
[517.292086] Starting dynamic subtest: vcs0
[517.365470] Dynamic subtest vcs0: SUCCESS (0.091s)
[517.380234] Starting dynamic subtest: vcs1
[517.454411] Dynamic subtest vcs1: SUCCESS (0.086s)
[517.471769] Starting dynamic subtest: vecs0
[517.535901] Dynamic subtest vecs0: SUCCESS (0.079s)
[517.555983] Starting dynamic subtest: ccs0
[517.620675] Dynamic subtest ccs0: SUCCESS (0.083s)
[517.623501] Subtest Q-promotion: SUCCESS (0.460s)
[518.936612] [081/133] (516s left) gem_exec_params (invalid-bsd-ring)
[518.985054] Starting subtest: invalid-bsd-ring
[518.987502] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[519.091754] [082/133] (516s left) gem_reg_read (bad-register)
[519.146291] Starting subtest: bad-register
[519.148274] Subtest bad-register: SUCCESS (0.000s)
[519.239221] [083/133] (516s left) gem_workarounds (reset-context)
[519.297963] Starting subtest: reset-context
[519.485569] Subtest reset-context: SUCCESS (0.187s)
[519.615134] [084/133] (516s left) gem_exec_schedule (fairslice)
[519.678188] Starting subtest: fairslice
[519.680503] Starting dynamic subtest: rcs0
[521.707128] Dynamic subtest rcs0: SUCCESS (2.031s)
[521.717580] Starting dynamic subtest: bcs0
[523.727997] Dynamic subtest bcs0: SUCCESS (2.023s)
[523.740528] Starting dynamic subtest: vcs0
[525.751230] Dynamic subtest vcs0: SUCCESS (2.021s)
[525.764276] Starting dynamic subtest: vcs1
[527.770002] Dynamic subtest vcs1: SUCCESS (2.020s)
[527.782743] Starting dynamic subtest: vecs0
[529.796216] Dynamic subtest vecs0: SUCCESS (2.026s)
[529.807427] Starting dynamic subtest: ccs0
[531.817601] Dynamic subtest ccs0: SUCCESS (2.022s)
[531.819700] Subtest fairslice: SUCCESS (12.147s)
[532.116430] [085/133] (503s left) kms_dsc (dsc-with-bpc)
[532.215504] Starting subtest: dsc-with-bpc
[532.247235] Subtest dsc-with-bpc: SKIP (0.001s)
[532.290845] [086/133] (503s left) kms_getfb (getfb-handle-protection)
[532.375304] Starting subtest: getfb-handle-protection
[532.395768] Subtest getfb-handle-protection: SUCCESS (0.022s)
[532.538682] [087/133] (503s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[532.641172] Starting subtest: cursor-vs-flip-legacy
[562.286606] Subtest cursor-vs-flip-legacy: SUCCESS (29.638s)
[563.120989] [088/133] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[563.206135] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[563.210354] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[563.310014] [089/133] (472s left) gem_workarounds (suspend-resume-fd)
[563.373108] Starting subtest: suspend-resume-fd
[579.969887] Subtest suspend-resume-fd: SUCCESS (1.167s)
[580.128733] [090/133] (455s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[580.224642] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[580.228706] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[580.313878] [091/133] (455s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[580.419550] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[580.423953] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[580.526936] [092/133] (455s left) syncobj_basic (illegal-fd-to-handle)
[580.584191] Starting subtest: illegal-fd-to-handle
[580.586539] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[580.684862] [093/133] (455s left) gem_exec_balancer (invalid-bonds)
[580.736985] Starting subtest: invalid-bonds
[580.741237] Subtest invalid-bonds: SKIP (0.000s)
[581.048480] [094/133] (455s left) vgem_basic (setversion)
[581.086519] Starting subtest: setversion
[581.090518] Subtest setversion: SUCCESS (0.000s)
[581.155853] [095/133] (455s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[581.245875] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[581.249921] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[581.327261] [096/133] (454s left) gem_eio (in-flight-1us)
[581.533201] Starting subtest: in-flight-1us
[589.823606] Subtest in-flight-1us: SUCCESS (8.343s)
[590.003461] [097/133] (446s left) kms_lease (cursor-implicit-plane)
[590.092914] Starting subtest: cursor-implicit-plane
[590.095353] Starting dynamic subtest: pipe-A-eDP-1
[590.550674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[590.562359] Starting dynamic subtest: pipe-B-eDP-1
[591.678535] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[591.690437] Starting dynamic subtest: pipe-C-eDP-1
[592.790980] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[592.801917] Starting dynamic subtest: pipe-D-eDP-1
[593.915898] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[593.917916] Subtest cursor-implicit-plane: SUCCESS (3.836s)
[594.770438] [098/133] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[594.871309] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[594.875706] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[594.966234] [099/133] (441s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[595.063402] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[595.067996] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[596.206523] [100/133] (440s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[596.311670] Starting subtest: cursorA-vs-flipA-toggle
[607.426308] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.127s)
[608.218517] [101/133] (428s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[608.322153] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[608.324430] Starting dynamic subtest: pipe-A-default-mode
[609.493167] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[609.497481] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.170s)
[609.639811] [102/133] (426s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[609.715351] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[609.717671] Starting dynamic subtest: pipe-A-eDP-1
[609.737913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[609.751970] Starting dynamic subtest: pipe-B-eDP-1
[609.771840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[609.784586] Starting dynamic subtest: pipe-C-eDP-1
[609.803247] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[609.815990] Starting dynamic subtest: pipe-D-eDP-1
[609.835701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[609.837947] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[611.921756] [103/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[612.009880] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[612.014330] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[612.123616] [104/133] (424s left) gem_pread (bench)
[612.182156] Subtest bench: SKIP (0.000s)
[612.238341] [105/133] (424s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[612.333979] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[612.336355] Starting dynamic subtest: pipe-A-eDP-1
[612.418355] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[612.431777] Starting dynamic subtest: pipe-B-eDP-1
[613.595750] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[613.600182] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.269s)
[614.799616] [106/133] (421s left) gem_linear_blits (normal)
[615.237760] Starting subtest: normal
[619.054934] Subtest normal: SUCCESS (3.814s)
[619.253450] [107/133] (417s left) kms_chamelium_frames (dp-crc-multiple)
[619.711169] Subtest dp-crc-multiple: SKIP (0.000s)
[620.511025] [108/133] (416s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[620.637915] Starting subtest: flip-vs-cursor-busy-crc-legacy
[621.501528] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.861s)
[622.358446] [109/133] (414s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[622.473166] Starting subtest: cursor-tearing-framebuffer-change
[622.475491] Starting dynamic subtest: pipe-A-eDP-1
[623.042152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[623.053505] Starting dynamic subtest: pipe-D-eDP-1
[624.294461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[624.296661] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.820s)
[625.144153] [110/133] (411s left) kms_properties (connector-properties-legacy)
[625.231879] Starting subtest: connector-properties-legacy
[625.234080] Starting dynamic subtest: pipe-A-eDP-1
[632.933627] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.698s)
[632.947712] Starting dynamic subtest: pipe-None-DP-1
[632.952254] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[632.963248] Starting dynamic subtest: pipe-None-HDMI-A-1
[632.967235] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[632.978468] Starting dynamic subtest: pipe-None-DP-2
[632.983232] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[632.996671] Starting dynamic subtest: pipe-None-HDMI-A-2
[633.001120] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[633.012582] Starting dynamic subtest: pipe-None-DP-3
[633.016754] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[633.027580] Starting dynamic subtest: pipe-None-DP-4
[633.031759] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[633.033896] Subtest connector-properties-legacy: SUCCESS (7.709s)
[633.798754] [111/133] (403s left) syncobj_timeline (wait-any-snapshot)
[633.861184] Starting subtest: wait-any-snapshot
[633.942536] Subtest wait-any-snapshot: SUCCESS (0.081s)
[634.038586] [112/133] (402s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[634.146473] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[634.150431] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[634.248964] [113/133] (402s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[634.316395] Starting subtest: y-tiled-to-vebox-yf-tiled
[634.321060] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[634.501585] [114/133] (402s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[634.618155] Starting subtest: cursor-vs-flip-atomic
[664.253957] Subtest cursor-vs-flip-atomic: SUCCESS (29.639s)
[665.122036] [115/133] (372s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[665.186573] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[665.318943] [116/133] (371s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[665.414668] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[669.446035] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.037s)
[670.641540] [117/133] (366s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[670.739601] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[670.743922] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[670.844488] [118/133] (366s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[670.940701] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[670.945177] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[671.067914] [119/133] (366s left) prime_self_import (export-vs-gem_close-race)
[671.112333] Starting subtest: export-vs-gem_close-race
[676.210697] Subtest export-vs-gem_close-race: SUCCESS (5.102s)
[676.292721] [120/133] (361s left) prime_mmap_coherency (write)
[676.358187] Starting subtest: write
[681.737690] Subtest write: SUCCESS (5.377s)
[681.877133] [121/133] (355s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[681.944363] Subtest untiled-to-tiled: SKIP (0.000s)
[682.027227] [122/133] (355s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[682.112961] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[688.916224] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.804s)
[689.058889] [123/133] (348s left) gem_create (create-massive)
[689.118487] Starting subtest: create-massive
[689.120730] Subtest create-massive: SUCCESS (0.000s)
[689.313341] [124/133] (348s left) gem_exec_params (secure-non-master)
[689.368195] Starting subtest: secure-non-master
[689.372743] Subtest secure-non-master: SKIP (0.000s)
[689.464223] [125/133] (348s left) perf_pmu (busy-start)
[689.502420] Starting subtest: busy-start
[689.504699] Starting dynamic subtest: rcs0
[692.053772] Dynamic subtest rcs0: SUCCESS (2.551s)
[692.067874] Starting dynamic subtest: bcs0
[694.604793] Dynamic subtest bcs0: SUCCESS (2.548s)
[694.618755] Starting dynamic subtest: vcs0
[698.240134] Dynamic subtest vcs0: SUCCESS (3.632s)
[698.254829] Starting dynamic subtest: vcs1
[702.271984] Dynamic subtest vcs1: SUCCESS (4.029s)
[702.287146] Starting dynamic subtest: vecs0
[706.240194] Dynamic subtest vecs0: SUCCESS (3.965s)
[706.254716] Starting dynamic subtest: ccs0
[708.789820] Dynamic subtest ccs0: SUCCESS (2.548s)
[708.792855] Subtest busy-start: SUCCESS (19.287s)
[708.911429] [126/133] (328s left) gem_ctx_isolation (preservation)
[708.986572] Starting subtest: preservation
[708.989050] Starting dynamic subtest: rcs0
[709.158065] Dynamic subtest rcs0: SUCCESS (0.171s)
[709.173144] Starting dynamic subtest: bcs0
[709.335550] Dynamic subtest bcs0: SUCCESS (0.177s)
[709.352414] Starting dynamic subtest: vcs0
[709.487748] Dynamic subtest vcs0: SUCCESS (0.151s)
[709.499466] Starting dynamic subtest: vcs1
[711.357030] Dynamic subtest vcs1: SUCCESS (1.869s)
[711.369195] Starting dynamic subtest: vecs0
[713.394001] Dynamic subtest vecs0: SUCCESS (2.036s)
[713.409713] Starting dynamic subtest: ccs0
[715.405145] Dynamic subtest ccs0: SUCCESS (2.010s)
[715.407923] Subtest preservation: SUCCESS (6.419s)
[715.640883] [127/133] (322s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[715.735756] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[716.415780] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[716.579621] [128/133] (321s left) kms_flip (busy-flip)
[716.670564] Starting subtest: busy-flip
[716.672783] Starting dynamic subtest: A-eDP1
[718.332808] Dynamic subtest A-eDP1: SUCCESS (1.662s)
[718.344264] Starting dynamic subtest: B-eDP1
[719.965360] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[719.979037] Starting dynamic subtest: C-eDP1
[721.683084] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[721.696057] Starting dynamic subtest: D-eDP1
[723.321780] Dynamic subtest D-eDP1: SUCCESS (1.638s)
[723.326725] Subtest busy-flip: SUCCESS (6.657s)
[724.496902] [129/133] (313s left) gem_ctx_persistence (legacy-engines-mixed)
[724.562089] Starting subtest: legacy-engines-mixed
[724.564266] Starting dynamic subtest: render
[724.656683] Dynamic subtest render: SUCCESS (0.096s)
[724.671716] Starting dynamic subtest: bsd1
[724.713143] Dynamic subtest bsd1: SUCCESS (0.053s)
[724.724902] Starting dynamic subtest: bsd2
[724.759761] Dynamic subtest bsd2: SUCCESS (0.044s)
[724.772599] Starting dynamic subtest: blt
[724.822797] Dynamic subtest blt: SUCCESS (0.061s)
[724.838672] Starting dynamic subtest: vebox
[724.875707] Dynamic subtest vebox: SUCCESS (0.050s)
[724.878142] Subtest legacy-engines-mixed: SUCCESS (0.317s)
[724.957641] [130/133] (312s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[725.058128] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[726.148359] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s)
[726.279397] [131/133] (311s left) kms_vblank (wait-forked-busy-hang)
[726.373309] Starting subtest: wait-forked-busy-hang
[726.375211] Starting dynamic subtest: pipe-A-eDP-1
[753.026663] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.655s)
[753.044479] Starting dynamic subtest: pipe-D-eDP-1
[767.995353] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.970s)
[767.997497] Subtest wait-forked-busy-hang: SUCCESS (41.629s)
[768.872348] [132/133] (269s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[769.242372] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[770.070005] [133/133] (267s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[770.130670] Starting subtest: invalid-bsd1-flag-on-blt
[770.133015] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[770.232713] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: i915_selftest
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_pm_dc
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: gen9_exec_parse
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_busy
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: core_hotunplug
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_panel_fitting
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_psr_stress_test
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_busy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_basic
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: gem_softpin
results: parsing output: 50/ for test: core_auth
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_joiner
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_ccs
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_dp_link_training
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: core_getversion
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: kms_content_protection
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_pipe_stress
results: parsing output: 76/ for test: kms_sequence
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_color_pipeline
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: gem_reg_read
results: parsing output: 82/ for test: gem_workarounds
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_dsc
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_workarounds
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_basic
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: vgem_basic
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_pread
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_linear_blits
results: parsing output: 106/ for test: kms_chamelium_frames
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_properties
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: prime_mmap_coherency
results: parsing output: 120/ for test: gem_set_tiling_vs_blt
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_create
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: gem_ctx_isolation
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: kms_chamelium_hpd
results: parsing output: 132/ for test: gem_exec_params
Done.