[61.846516] Initializing watchdogs
[61.846577]   /dev/watchdog0
[61.862270] [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.866774] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.869267] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.873106] [001/155] (960s left) gem_ctx_freq (sysfs)
[61.965911] Starting subtest: sysfs
[61.968163] Starting dynamic subtest: gt0
[67.527108] Dynamic subtest gt0: SUCCESS (5.602s)
[67.537075] Starting dynamic subtest: gt1
[109.321237] Dynamic subtest gt1: SUCCESS (41.822s)
[109.324249] Subtest sysfs: SUCCESS (47.425s)
[109.431082] [002/155] (912s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[109.494135] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[109.498640] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[109.677846] [003/155] (912s left) gem_exec_whisper (basic-queues-priority)
[109.742893] Starting subtest: basic-queues-priority
[134.378307] Subtest basic-queues-priority: SUCCESS (24.633s)
[134.561402] [004/155] (887s left) i915_pm_freq_api (freq-basic-api)
[134.628047] Starting subtest: freq-basic-api
[134.630457] Starting dynamic subtest: gt0
[134.632858] Dynamic subtest gt0: SUCCESS (0.004s)
[134.643943] Starting dynamic subtest: gt1
[134.645845] Dynamic subtest gt1: SUCCESS (0.002s)
[134.647613] Subtest freq-basic-api: SUCCESS (0.007s)
[134.715543] [005/155] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[134.818569] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[134.823072] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[134.918937] [006/155] (887s left) kms_force_connector_basic (prune-stale-modes)
[134.993983] Starting subtest: prune-stale-modes
[135.438767] Subtest prune-stale-modes: SUCCESS (0.444s)
[135.571823] [007/155] (887s left) gem_ctx_shared (q-in-order)
[135.632335] Starting subtest: Q-in-order
[135.634342] Starting dynamic subtest: rcs0
[135.778881] Dynamic subtest rcs0: SUCCESS (0.144s)
[135.795307] Starting dynamic subtest: vcs0
[135.860084] Dynamic subtest vcs0: SUCCESS (0.082s)
[135.876093] Starting dynamic subtest: vcs1
[135.940425] Dynamic subtest vcs1: SUCCESS (0.080s)
[135.957560] Starting dynamic subtest: vecs0
[136.013754] Dynamic subtest vecs0: SUCCESS (0.073s)
[136.029661] Starting dynamic subtest: ccs0
[136.104391] Dynamic subtest ccs0: SUCCESS (0.091s)
[136.107033] Subtest Q-in-order: SUCCESS (0.472s)
[137.373854] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[137.377284] [008/155] (885s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[137.480397] Starting subtest: fbchdr-1p-rte
[137.484481] Subtest fbchdr-1p-rte: SKIP (0.000s)
[137.582894] [009/155] (885s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[137.676994] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[137.681573] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[137.755625] [010/155] (884s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[137.850094] Starting subtest: stress-xrgb8888-xtiled
[143.759228] Subtest stress-xrgb8888-xtiled: SUCCESS (5.909s)
[143.811627] [011/155] (878s left) kms_cursor_crc (cursor-random-32x10)
[143.966519] Starting subtest: cursor-random-32x10
[144.021992] Subtest cursor-random-32x10: SKIP (0.050s)
[144.292742] [012/155] (878s left) prime_busy (hang-wait)
[144.347733] Starting subtest: hang-wait
[144.349761] Starting dynamic subtest: rcs0
[171.758479] Dynamic subtest rcs0: SUCCESS (27.404s)
[171.769463] Starting dynamic subtest: bcs0
[178.908611] Dynamic subtest bcs0: SUCCESS (7.150s)
[178.919357] Starting dynamic subtest: vcs0
[185.880848] Dynamic subtest vcs0: SUCCESS (6.974s)
[185.890931] Starting dynamic subtest: vcs1
[192.920048] Dynamic subtest vcs1: SUCCESS (7.036s)
[192.931075] Starting dynamic subtest: vecs0
[199.891782] Dynamic subtest vecs0: SUCCESS (6.974s)
[199.903189] Starting dynamic subtest: ccs0
[213.799766] Dynamic subtest ccs0: SUCCESS (13.903s)
[213.802559] Subtest hang-wait: SUCCESS (69.445s)
[213.922268] [013/155] (808s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[214.031684] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[214.035906] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[214.132856] [014/155] (808s left) gem_mmap_offset (partial-mmap)
[214.178013] Starting subtest: partial-mmap
[214.180328] Starting dynamic subtest: smem0
[214.182314] Dynamic subtest smem0: SUCCESS (0.004s)
[214.184298] Subtest partial-mmap: SUCCESS (0.004s)
[214.287897] [015/155] (808s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[214.380084] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[214.384195] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[214.459821] [016/155] (808s left) syncobj_wait (multi-wait-submitted-signaled)
[214.516967] Starting subtest: multi-wait-submitted-signaled
[214.519858] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[214.627406] [017/155] (808s left) kms_psr (fbc-pr-cursor-render)
[214.714276] Starting subtest: fbc-pr-cursor-render
[214.719484] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[214.783367] [018/155] (808s left) gem_userptr_blits (stress-mm-invalidate-close)
[214.854883] Starting subtest: stress-mm-invalidate-close
[217.003382] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[217.147034] [019/155] (805s left) gem_exec_reloc (basic-cpu-read)
[217.214240] Subtest basic-cpu-read: SKIP (0.000s)
[217.272083] [020/155] (805s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[217.327538] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[217.427772] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[217.505726] [021/155] (805s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[217.610356] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[217.614679] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[217.708885] [022/155] (805s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[217.815774] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[217.820337] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[217.907087] [023/155] (805s left) syncobj_timeline (invalid-signal-bad-pad)
[217.961033] Starting subtest: invalid-signal-bad-pad
[217.963069] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[218.075092] [024/155] (805s left) kms_content_protection (lic-type-0)
[218.225706] Starting subtest: lic-type-0
[218.230235] Subtest lic-type-0: SKIP (0.000s)
[218.364589] [025/155] (804s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[218.460358] Starting subtest: 4-tiled-64bpp-rotate-270
[218.479395] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[218.592377] [026/155] (804s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[218.683872] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[218.687448] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.781712] [027/155] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[218.869762] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[218.873238] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.987152] [028/155] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[219.080331] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[226.423153] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.346s)
[226.557140] [029/155] (796s left) kms_chamelium_audio (dp-audio-edid)
[226.956527] Subtest dp-audio-edid: SKIP (0.000s)
[227.740784] [030/155] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[227.839073] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[227.843109] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[227.927800] [031/155] (795s left) gem_softpin (evict-prime-sanity-check)
[227.976826] Starting subtest: evict-prime-sanity-check
[227.979584] Starting dynamic subtest: rcs0
[229.130620] Dynamic subtest rcs0: SUCCESS (1.153s)
[229.142807] Starting dynamic subtest: bcs0
[230.246792] Dynamic subtest bcs0: SUCCESS (1.116s)
[230.257784] Starting dynamic subtest: vcs0
[232.334045] Dynamic subtest vcs0: SUCCESS (2.085s)
[232.344662] Starting dynamic subtest: vcs1
[234.303578] Dynamic subtest vcs1: SUCCESS (1.968s)
[234.313804] Starting dynamic subtest: vecs0
[236.284800] Dynamic subtest vecs0: SUCCESS (1.980s)
[236.299994] Starting dynamic subtest: ccs0
[237.414800] Dynamic subtest ccs0: SUCCESS (1.130s)
[237.426327] Starting dynamic subtest: all
[238.535724] Dynamic subtest all: SUCCESS (1.119s)
[238.538708] Subtest evict-prime-sanity-check: SUCCESS (10.559s)
[238.617255] [032/155] (785s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[238.744504] Starting subtest: basic-flip-after-cursor-legacy
[239.665074] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.920s)
[240.541892] [033/155] (783s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[240.641228] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[240.643510] Starting dynamic subtest: pipe-A-eDP-1
[240.789825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[240.801460] Starting dynamic subtest: pipe-B-eDP-1
[240.821676] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[240.831058] Starting dynamic subtest: pipe-C-eDP-1
[240.850610] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[240.859536] Starting dynamic subtest: pipe-D-eDP-1
[240.879257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[240.881440] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.147s)
[243.046159] [034/155] (780s left) api_intel_allocator (reloc-allocator)
[243.105902] Starting subtest: reloc-allocator
[243.108313] Starting dynamic subtest: basic
[243.110624] Dynamic subtest basic: SUCCESS (0.003s)
[243.122446] Starting dynamic subtest: parallel-one
[243.124628] Dynamic subtest parallel-one: SUCCESS (0.008s)
[243.136683] Starting dynamic subtest: print
[243.138782] Dynamic subtest print: SUCCESS (0.000s)
[243.147719] Starting dynamic subtest: reuse
[243.149837] Dynamic subtest reuse: SUCCESS (0.000s)
[243.158594] Starting dynamic subtest: fork-reopen-allocator
[243.160743] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[243.162906] Subtest reloc-allocator: SUCCESS (0.024s)
[243.261501] [035/155] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[243.363470] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[243.367700] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[243.466576] [036/155] (780s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[243.558214] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[243.562373] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[243.646840] [037/155] (780s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[243.752080] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[243.756681] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[243.852986] [038/155] (780s left) gem_media_vme
[243.984553] [039/155] (779s left) gem_exec_reloc (basic-wc-noreloc)
[244.037302] Subtest basic-wc-noreloc: SKIP (0.000s)
[244.103705] [040/155] (779s left) kms_async_flips (test-time-stamp-atomic)
[244.195895] Starting subtest: test-time-stamp-atomic
[244.573399] Starting dynamic subtest: pipe-A-eDP-1
[245.416539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[245.795055] Starting dynamic subtest: pipe-B-eDP-1
[246.611554] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s)
[247.003677] Starting dynamic subtest: pipe-C-eDP-1
[247.817184] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.818s)
[248.196150] Starting dynamic subtest: pipe-D-eDP-1
[249.013246] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.821s)
[249.015731] Subtest test-time-stamp-atomic: SUCCESS (4.816s)
[250.236599] [041/155] (773s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[250.296843] Starting subtest: mixed-tiled-to-y-tiled-ccs
[250.301392] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[250.491278] [042/155] (773s left) kms_rotation_crc (multiplane-rotation)
[250.596744] Starting subtest: multiplane-rotation
[268.087151] Subtest multiplane-rotation: SUCCESS (17.493s)
[268.205701] [043/155] (755s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[268.311546] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[268.313465] Starting dynamic subtest: pipe-A-default-mode
[271.041400] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[271.043800] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.731s)
[271.937875] [044/155] (752s left) gem_sync (basic-all)
[272.008946] Starting subtest: basic-all
[275.275060] Subtest basic-all: SUCCESS (3.274s)
[275.459928] [045/155] (748s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[275.564874] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[280.111832] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.552s)
[281.256263] [046/155] (742s left) gem_exec_flush (basic-wb-pro-default)
[281.307621] Starting subtest: basic-wb-pro-default
[286.769617] Subtest basic-wb-pro-default: SUCCESS (5.461s)
[286.958109] [047/155] (737s left) gem_render_copy_redux (interruptible)
[287.031183] Starting subtest: interruptible
[287.405247] Subtest interruptible: SUCCESS (0.377s)
[287.548714] [048/155] (736s left) gem_workarounds (reset)
[287.611370] Starting subtest: reset
[287.812202] Subtest reset: SUCCESS (0.201s)
[287.924479] [049/155] (736s left) perf (polling-parameterized)
[288.054732] Starting subtest: polling-parameterized
[308.075386] Subtest polling-parameterized: SUCCESS (20.018s)
[308.127443] [050/155] (716s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[308.241604] Starting subtest: hdr-2p-pri-indfb-multidraw
[308.246092] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[308.322406] [051/155] (716s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[308.416714] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[308.420705] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[308.525343] [052/155] (715s left) gem_mmap_wc (read-write)
[308.571740] Subtest read-write: SKIP (0.000s)
[308.633421] [053/155] (715s left) kms_dsc (dsc-fractional-bpp)
[308.720728] Starting subtest: dsc-fractional-bpp
[308.733600] Subtest dsc-fractional-bpp: SKIP (0.001s)
[308.796718] [054/155] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[308.901645] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[308.906189] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[308.992749] [055/155] (715s left) gem_request_retire (retire-vma-not-inactive)
[309.054954] Starting subtest: retire-vma-not-inactive
[309.113773] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[309.264457] [056/155] (715s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[309.358753] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[309.360598] Starting dynamic subtest: pipe-A-eDP-1
[309.889761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.507s)
[309.901369] Starting dynamic subtest: pipe-B-eDP-1
[311.408348] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.511s)
[311.418851] Starting dynamic subtest: pipe-C-eDP-1
[312.803230] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[312.815049] Starting dynamic subtest: pipe-D-eDP-1
[314.207105] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[314.209296] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.820s)
[315.439247] [057/155] (709s left) api_intel_bb (simple-bb)
[315.496891] Starting subtest: simple-bb
[315.499391] Subtest simple-bb: SUCCESS (0.004s)
[315.613281] [058/155] (709s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[315.708238] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[316.731449] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.023s)
[316.854875] [059/155] (707s left) dumb_buffer (create-valid-dumb)
[316.912045] Starting subtest: create-valid-dumb
[316.913963] Subtest create-valid-dumb: SUCCESS (0.000s)
[317.021077] [060/155] (707s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[317.120793] Starting subtest: y-tiled-8bpp-rotate-180
[317.124440] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[317.219111] [061/155] (707s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[317.312719] Starting subtest: plane-primary-toggle-with-vblank-wait
[317.314538] Starting dynamic subtest: pipe-A-eDP-1
[317.486249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[317.792775] Starting dynamic subtest: pipe-B-eDP-1
[318.697432] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.913s)
[318.998199] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.686s)
[319.836794] [062/155] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[319.940565] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[321.165126] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (1.060s)
[321.208031] [063/155] (703s left) gem_exec_reloc (basic-scanout)
[321.265102] Subtest basic-scanout: SKIP (0.000s)
[321.331515] [064/155] (703s left) perf_pmu (busy-accuracy-98)
[321.366820] Starting subtest: busy-accuracy-98
[321.368642] Starting dynamic subtest: rcs0
[324.408421] Dynamic subtest rcs0: SUCCESS (3.039s)
[324.419443] Starting dynamic subtest: bcs0
[327.459931] Dynamic subtest bcs0: SUCCESS (3.050s)
[327.469540] Starting dynamic subtest: vcs0
[330.500698] Dynamic subtest vcs0: SUCCESS (3.038s)
[330.512604] Starting dynamic subtest: vcs1
[333.544646] Dynamic subtest vcs1: SUCCESS (3.040s)
[333.555927] Starting dynamic subtest: vecs0
[336.587092] Dynamic subtest vecs0: SUCCESS (3.041s)
[336.597493] Starting dynamic subtest: ccs0
[339.643111] Dynamic subtest ccs0: SUCCESS (3.053s)
[339.645918] Subtest busy-accuracy-98: SUCCESS (18.276s)
[339.773656] [065/155] (685s left) gem_pread (display)
[339.830295] Subtest display: SKIP (0.000s)
[339.889768] [066/155] (685s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[339.952679] Subtest writes-after-reads-uncached: SKIP (0.000s)
[340.018979] [067/155] (685s left) gem_softpin (softpin)
[340.084688] Starting subtest: softpin
[372.352954] Subtest softpin: SUCCESS (32.264s)
[372.470409] [068/155] (652s left) kms_addfb_basic (invalid-get-prop-any)
[372.527097] Starting subtest: invalid-get-prop-any
[372.529153] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[372.695403] [069/155] (652s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[373.075874] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[373.899927] [070/155] (651s left) kms_pm_rpm (i2c)
[375.423790] Starting subtest: i2c
[380.836925] Subtest i2c: SUCCESS (5.413s)
[380.957621] [071/155] (644s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[381.064172] Starting subtest: plane-lut1d-pre-ctm3x4
[381.211408] Starting dynamic subtest: pipe-A-plane-0
[381.366802] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[381.376865] Starting dynamic subtest: pipe-A-plane-1
[381.533864] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[381.546251] Starting dynamic subtest: pipe-A-plane-2
[381.723086] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[382.926978] Starting dynamic subtest: pipe-B-plane-0
[383.095892] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[383.106102] Starting dynamic subtest: pipe-B-plane-1
[383.251506] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[383.261208] Starting dynamic subtest: pipe-B-plane-2
[383.428923] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[384.647678] Starting dynamic subtest: pipe-C-plane-0
[384.784610] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[384.794589] Starting dynamic subtest: pipe-C-plane-1
[384.951267] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[384.963758] Starting dynamic subtest: pipe-C-plane-2
[385.106073] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[386.292291] Starting dynamic subtest: pipe-D-plane-0
[386.450308] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[386.460456] Starting dynamic subtest: pipe-D-plane-1
[386.617058] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[386.626896] Starting dynamic subtest: pipe-D-plane-2
[386.773279] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[387.064574] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.998s)
[387.958076] [072/155] (637s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[388.061520] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[388.063969] Starting dynamic subtest: pipe-A
[388.123707] Dynamic subtest pipe-A: SUCCESS (0.064s)
[388.135809] Starting dynamic subtest: pipe-B
[389.278811] Dynamic subtest pipe-B: SUCCESS (1.154s)
[389.290722] Starting dynamic subtest: pipe-C
[390.399777] Dynamic subtest pipe-C: SUCCESS (1.119s)
[390.410218] Starting dynamic subtest: pipe-D
[391.530397] Dynamic subtest pipe-D: SUCCESS (1.130s)
[391.532731] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.472s)
[392.672997] [073/155] (632s left) gem_exec_balancer (sliced)
[392.737935] Starting subtest: sliced
[392.742484] Subtest sliced: SKIP (0.000s)
[393.076815] [074/155] (632s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[393.181265] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[393.185637] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[393.289322] [075/155] (632s left) gem_sync (basic-store-each)
[393.357709] Starting subtest: basic-store-each
[395.948246] Subtest basic-store-each: SUCCESS (2.600s)
[396.136503] [076/155] (629s left) kms_psr (pr-cursor-mmap-gtt)
[396.233105] Starting subtest: pr-cursor-mmap-gtt
[396.237610] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[396.305973] [077/155] (629s left) kms_psr (psr2-sprite-render)
[396.392285] Starting subtest: psr2-sprite-render
[396.394605] Starting dynamic subtest: eDP-1
[398.164953] Dynamic subtest eDP-1: SUCCESS (1.771s)
[398.167261] Subtest psr2-sprite-render: SUCCESS (1.772s)
[399.043996] [078/155] (626s left) prime_self_import (basic-with_two_bos)
[399.075591] Starting subtest: basic-with_two_bos
[399.089074] Subtest basic-with_two_bos: SUCCESS (0.015s)
[399.187967] [079/155] (626s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[399.275735] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[399.280057] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[399.361845] [080/155] (626s left) kms_setmode (basic)
[399.416421] Starting subtest: basic
[399.741954] Starting dynamic subtest: pipe-A-eDP-1
[401.858721] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[402.211995] Starting dynamic subtest: pipe-B-eDP-1
[404.289253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.086s)
[404.603652] Subtest basic: SUCCESS (5.185s)
[405.437297] [081/155] (620s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[405.545851] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[405.550020] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[405.653324] [082/155] (620s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[405.705042] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[405.815382] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[405.895096] [083/155] (619s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[405.990481] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[405.994828] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[406.086533] [084/155] (619s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[406.182932] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[406.187523] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[406.280149] [085/155] (619s left) kms_plane_multiple (tiling-none)
[406.374334] Starting subtest: tiling-none
[406.376619] Starting dynamic subtest: pipe-A-eDP-1
[410.179701] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.804s)
[410.191228] Starting dynamic subtest: pipe-B-eDP-1
[414.909969] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.728s)
[414.920428] Starting dynamic subtest: pipe-C-eDP-1
[419.372988] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.464s)
[419.384581] Starting dynamic subtest: pipe-D-eDP-1
[423.905983] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.530s)
[423.908270] Subtest tiling-none: SUCCESS (17.532s)
[424.724187] [086/155] (601s left) gem_userptr_blits (unsync-overlap)
[424.797622] Subtest unsync-overlap: SKIP (0.000s)
[424.964869] [087/155] (601s left) kms_busy (extended-modeset-hang-newfb)
[425.060999] Starting subtest: extended-modeset-hang-newfb
[425.063230] Starting dynamic subtest: pipe-A
[459.208199] Dynamic subtest pipe-A: SUCCESS (34.144s)
[459.218668] Starting dynamic subtest: pipe-D
[482.204792] Dynamic subtest pipe-D: SUCCESS (22.994s)
[482.207210] Subtest extended-modeset-hang-newfb: SUCCESS (57.143s)
[483.096878] [088/155] (542s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[483.230666] Starting subtest: cursorA-vs-flipB-toggle
[483.235356] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[483.379871] [089/155] (542s left) gem_mmap_wc (bad-object)
[483.438984] Subtest bad-object: SKIP (0.000s)
[483.499360] [090/155] (542s left) kms_vblank (wait-forked-busy)
[483.585808] Starting subtest: wait-forked-busy
[483.587771] Starting dynamic subtest: pipe-A-eDP-1
[485.473847] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[485.488650] Starting dynamic subtest: pipe-D-eDP-1
[488.075515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[488.077671] Subtest wait-forked-busy: SUCCESS (4.492s)
[488.881232] [091/155] (537s left) gem_exec_schedule (preemptive-hang)
[489.064695] Starting subtest: preemptive-hang
[489.066954] Starting dynamic subtest: rcs0
[498.418622] Dynamic subtest rcs0: SUCCESS (9.357s)
[498.428384] Starting dynamic subtest: bcs0
[507.440976] Dynamic subtest bcs0: SUCCESS (9.021s)
[507.450934] Starting dynamic subtest: vcs0
[516.402525] Dynamic subtest vcs0: SUCCESS (8.958s)
[516.412751] Starting dynamic subtest: vcs1
[525.423994] Dynamic subtest vcs1: SUCCESS (9.023s)
[525.435726] Starting dynamic subtest: vecs0
[534.445426] Dynamic subtest vecs0: SUCCESS (9.021s)
[534.458635] Starting dynamic subtest: ccs0
[543.410049] Dynamic subtest ccs0: SUCCESS (8.962s)
[543.412810] Subtest preemptive-hang: SUCCESS (54.347s)
[543.647230] [092/155] (482s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[543.752486] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[543.756649] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[543.869374] [093/155] (482s left) gem_exec_schedule (submit-late-slice)
[543.936439] Starting subtest: submit-late-slice
[543.938769] Starting dynamic subtest: rcs0
[543.969221] Dynamic subtest rcs0: SUCCESS (0.041s)
[543.983604] Starting dynamic subtest: bcs0
[544.006915] Dynamic subtest bcs0: SUCCESS (0.036s)
[544.020792] Starting dynamic subtest: vcs0
[544.036226] Dynamic subtest vcs0: SUCCESS (0.029s)
[544.046207] Starting dynamic subtest: vcs1
[544.081654] Dynamic subtest vcs1: SUCCESS (0.045s)
[544.094166] Starting dynamic subtest: vecs0
[544.121353] Dynamic subtest vecs0: SUCCESS (0.038s)
[544.135841] Starting dynamic subtest: ccs0
[544.164344] Dynamic subtest ccs0: SUCCESS (0.041s)
[544.166708] Subtest submit-late-slice: SUCCESS (0.237s)
[545.384129] [094/155] (480s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[545.443088] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[545.445585] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[545.546719] [095/155] (480s left) kms_psr (psr2-cursor-mmap-gtt)
[545.650169] Starting subtest: psr2-cursor-mmap-gtt
[545.652459] Starting dynamic subtest: eDP-1
[547.361140] Dynamic subtest eDP-1: SUCCESS (1.711s)
[547.363562] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.712s)
[548.248381] [096/155] (478s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[548.346184] Starting subtest: async-flip-with-page-flip-events-tiled
[548.737073] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[551.526411] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[551.539095] Starting dynamic subtest: pipe-A-eDP-1-4
[553.700501] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[553.710724] Starting dynamic subtest: pipe-A-eDP-1-x
[555.877942] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[556.254212] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[559.066099] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.821s)
[559.076633] Starting dynamic subtest: pipe-B-eDP-1-4
[561.250801] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s)
[561.263277] Starting dynamic subtest: pipe-B-eDP-1-x
[563.439987] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[563.805087] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[566.585535] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[566.599042] Starting dynamic subtest: pipe-C-eDP-1-4
[568.759321] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[568.772455] Starting dynamic subtest: pipe-C-eDP-1-x
[570.936813] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[571.306105] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[574.119618] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.824s)
[574.130341] Starting dynamic subtest: pipe-D-eDP-1-4
[576.294021] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[576.306819] Starting dynamic subtest: pipe-D-eDP-1-x
[578.471362] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.176s)
[578.473860] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (30.125s)
[579.693716] [097/155] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[579.792194] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[579.796533] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[579.892094] [098/155] (446s left) kms_getfb (getfb2-handle-protection)
[579.979561] Starting subtest: getfb2-handle-protection
[579.992400] Subtest getfb2-handle-protection: SUCCESS (0.015s)
[580.106792] [099/155] (446s left) gem_exec_suspend (basic-s0)
[580.165969] Starting subtest: basic-S0
[580.168216] Starting dynamic subtest: smem
[599.918217] Dynamic subtest smem: SUCCESS (6.124s)
[599.920540] Subtest basic-S0: SUCCESS (6.127s)
[600.102221] [100/155] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[600.242815] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[607.067982] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.948s)
[607.206424] [101/155] (419s left) kms_joiner (basic-force-ultra-joiner)
[607.312422] Starting subtest: basic-force-ultra-joiner
[607.316637] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[607.390817] [102/155] (419s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[607.489592] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[607.492068] Starting dynamic subtest: pipe-A
[607.602187] Dynamic subtest pipe-A: SKIP (0.109s)
[607.613998] Starting dynamic subtest: pipe-B
[608.745597] Dynamic subtest pipe-B: SKIP (1.153s)
[608.756465] Starting dynamic subtest: pipe-C
[609.975010] Dynamic subtest pipe-C: SUCCESS (1.245s)
[609.991623] Starting dynamic subtest: pipe-D
[611.214349] Dynamic subtest pipe-D: SUCCESS (1.247s)
[611.216960] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.757s)
[612.394896] [103/155] (414s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[612.441338] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[612.548045] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[612.631123] [104/155] (414s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[612.726455] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[612.730822] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[612.810584] [105/155] (413s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[612.915958] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[612.920179] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[613.002795] [106/155] (413s left) gem_exec_params (dr4-dirt)
[613.059795] Starting subtest: DR4-dirt
[613.061694] Subtest DR4-dirt: SUCCESS (0.000s)
[613.158951] [107/155] (413s left) i915_query (engine-info-invalid)
[613.212853] Starting subtest: engine-info-invalid
[613.214971] Subtest engine-info-invalid: SUCCESS (0.000s)
[613.331328] [108/155] (413s left) syncobj_wait (invalid-reset-bad-pad)
[613.373375] Starting subtest: invalid-reset-bad-pad
[613.375604] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[613.467738] [109/155] (413s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[613.558901] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[613.562528] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[613.659703] [110/155] (413s left) syncobj_wait (reset-signaled)
[613.712989] Starting subtest: reset-signaled
[613.714960] Subtest reset-signaled: SUCCESS (0.000s)
[613.834492] [111/155] (413s left) kms_lease (multimaster-lease)
[613.936101] Starting subtest: multimaster-lease
[613.939968] Subtest multimaster-lease: SUCCESS (0.004s)
[614.046179] [112/155] (413s left) gem_busy (semaphore)
[614.222106] Subtest semaphore: SKIP (0.000s)
[614.461811] [113/155] (412s left) vgem_basic (setversion)
[614.508795] Starting subtest: setversion
[614.513174] Subtest setversion: SUCCESS (0.000s)
[614.566771] [114/155] (412s left) core_auth (many-magics)
[614.610533] Starting subtest: many-magics
[615.380025] Subtest many-magics: SUCCESS (0.775s)
[615.560556] [115/155] (411s left) kms_chamelium_frames (dp-crc-fast)
[615.933171] Subtest dp-crc-fast: SKIP (0.000s)
[616.787263] [116/155] (410s left) gem_exec_reloc (basic-cpu-read-active)
[616.853926] Subtest basic-cpu-read-active: SKIP (0.000s)
[616.924304] [117/155] (410s left) kms_pm_rpm (modeset-non-lpsp-stress)
[619.162306] Starting subtest: modeset-non-lpsp-stress
[620.328947] Subtest modeset-non-lpsp-stress: SKIP (1.167s)
[620.721285] [118/155] (406s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[620.769809] Starting subtest: single-wait-for-submit-available-submitted
[620.771844] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[620.864567] [119/155] (406s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[620.955075] Starting subtest: 2x-plain-flip-ts-check-interruptible
[620.968108] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.012s)
[621.044642] [120/155] (406s left) i915_drm_fdinfo (busy-hang)
[621.082536] Starting subtest: busy-hang
[621.084430] Starting dynamic subtest: rcs0
[621.101363] Dynamic subtest rcs0: SKIP (0.019s)
[621.114294] Starting dynamic subtest: bcs0
[621.118536] Dynamic subtest bcs0: SKIP (0.001s)
[621.129018] Starting dynamic subtest: vcs0
[621.133398] Dynamic subtest vcs0: SKIP (0.000s)
[621.143381] Starting dynamic subtest: vcs1
[621.147543] Dynamic subtest vcs1: SKIP (0.000s)
[621.157659] Starting dynamic subtest: vecs0
[621.161790] Dynamic subtest vecs0: SKIP (0.000s)
[621.172118] Starting dynamic subtest: ccs0
[621.176235] Dynamic subtest ccs0: SKIP (0.000s)
[621.180278] Subtest busy-hang: SKIP (0.025s)
[621.219062] [121/155] (406s left) kms_cursor_crc (cursor-offscreen-256x85)
[621.462340] Starting subtest: cursor-offscreen-256x85
[621.509571] Subtest cursor-offscreen-256x85: SKIP (0.043s)
[621.692049] [122/155] (405s left) kms_properties (connector-properties-legacy)
[621.792703] Starting subtest: connector-properties-legacy
[621.794610] Starting dynamic subtest: pipe-A-eDP-1
[629.833391] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.048s)
[629.844588] Starting dynamic subtest: pipe-None-DP-1
[629.849217] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[629.859736] Starting dynamic subtest: pipe-None-HDMI-A-1
[629.864015] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[629.874089] Starting dynamic subtest: pipe-None-DP-2
[629.878155] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[629.888146] Starting dynamic subtest: pipe-None-HDMI-A-2
[629.892574] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[629.902944] Starting dynamic subtest: pipe-None-DP-3
[629.907363] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[629.917961] Starting dynamic subtest: pipe-None-DP-4
[629.921874] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[629.923729] Subtest connector-properties-legacy: SUCCESS (8.060s)
[630.711634] [123/155] (396s left) gen7_exec_parse (bitmasks)
[630.766702] Subtest bitmasks: SKIP (0.000s)
[630.840883] [124/155] (396s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[630.941296] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[638.299565] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.364s)
[638.438913] [125/155] (389s left) kms_prop_blob (invalid-set-prop-any)
[638.507432] Starting subtest: invalid-set-prop-any
[638.509817] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[638.622061] [126/155] (389s left) kms_dp_aux_dev (basic)
[638.671296] Starting subtest: basic
[638.891913] Subtest basic: SUCCESS (0.221s)
[638.979909] [127/155] (388s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[639.085288] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[639.089490] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[639.178067] [128/155] (388s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[639.281721] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[645.855084] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.579s)
[645.967792] [129/155] (381s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[646.073089] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[646.075270] Starting dynamic subtest: pipe-A-eDP-1
[646.173155] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[646.184457] Starting dynamic subtest: pipe-B-eDP-1
[647.371893] Dynamic subtest pipe-B-eDP-1: SKIP (1.198s)
[647.376816] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.301s)
[648.553107] [130/155] (379s left) gem_exec_balancer (individual)
[648.626489] Starting subtest: individual
[649.965860] Subtest individual: SUCCESS (1.338s)
[650.313118] [131/155] (377s left) gem_ctx_engines (execute-one)
[650.367835] Starting subtest: execute-one
[653.373868] Subtest execute-one: SUCCESS (3.007s)
[653.567199] [132/155] (374s left) gem_userptr_blits (process-exit-busy)
[653.640973] Starting subtest: process-exit-busy
[653.656871] Subtest process-exit-busy: SUCCESS (0.020s)
[653.781661] [133/155] (374s left) gem_vm_create (invalid-create)
[653.835506] Starting subtest: invalid-create
[653.840152] Subtest invalid-create: SUCCESS (0.003s)
[653.942956] [134/155] (374s left) gem_ctx_shared (detached-shared-gtt)
[654.011458] Starting subtest: detached-shared-gtt
[656.167139] Subtest detached-shared-gtt: SUCCESS (2.155s)
[656.483937] [135/155] (371s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[656.580334] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[656.584687] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[656.679641] [136/155] (371s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[656.776926] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[656.781440] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[656.875994] [137/155] (371s left) kms_panel_fitting (legacy)
[656.978927] Starting subtest: legacy
[656.981253] Starting dynamic subtest: pipe-A-eDP-1
[657.472899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[657.502266] Starting dynamic subtest: pipe-B-eDP-1
[658.990372] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[659.017974] Starting dynamic subtest: pipe-C-eDP-1
[660.496476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[660.524398] Starting dynamic subtest: pipe-D-eDP-1
[662.007446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.493s)
[662.009730] Subtest legacy: SUCCESS (5.033s)
[663.185320] [138/155] (364s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[663.293954] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[663.346441] [139/155] (364s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[663.449726] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[663.454118] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[663.540883] [140/155] (364s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[663.637993] Starting subtest: sprite-rotation-90-pos-100-0
[663.642273] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[663.724098] [141/155] (364s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[663.816661] Starting subtest: hdr-rgb101010-draw-render
[663.821209] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[663.908617] [142/155] (364s left) gem_exec_params (invalid-bsd-ring)
[663.973794] Starting subtest: invalid-bsd-ring
[663.975668] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[664.076984] [143/155] (364s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[664.161130] Starting subtest: crc-primary-suspend-y-tiled-ccs
[664.163042] Starting dynamic subtest: pipe-A-eDP-1
[664.170736] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[664.181898] Starting dynamic subtest: pipe-B-eDP-1
[664.189477] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[664.200037] Starting dynamic subtest: pipe-C-eDP-1
[664.207299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[664.216917] Starting dynamic subtest: pipe-D-eDP-1
[664.223823] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[664.227255] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[666.437906] [144/155] (361s left) gem_exec_fence (nb-await)
[666.618832] Starting subtest: nb-await
[666.621386] Starting dynamic subtest: rcs0
[666.682634] Dynamic subtest rcs0: SUCCESS (0.063s)
[666.695443] Starting dynamic subtest: bcs0
[666.742654] Dynamic subtest bcs0: SUCCESS (0.057s)
[666.754965] Starting dynamic subtest: vcs0
[666.802533] Dynamic subtest vcs0: SUCCESS (0.057s)
[666.816148] Starting dynamic subtest: vcs1
[666.862708] Dynamic subtest vcs1: SUCCESS (0.058s)
[666.875274] Starting dynamic subtest: vecs0
[666.921660] Dynamic subtest vecs0: SUCCESS (0.057s)
[666.935385] Starting dynamic subtest: ccs0
[666.981888] Dynamic subtest ccs0: SUCCESS (0.058s)
[666.984441] Subtest nb-await: SUCCESS (0.364s)
[669.051825] [145/155] (359s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[669.140011] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[669.142298] Starting dynamic subtest: pipe-A-eDP-1
[669.165642] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[669.177279] Starting dynamic subtest: pipe-B-eDP-1
[669.199485] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[669.210408] Starting dynamic subtest: pipe-C-eDP-1
[669.232169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[669.242795] Starting dynamic subtest: pipe-D-eDP-1
[669.265746] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[669.269873] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[671.432504] [146/155] (357s left) perf (invalid-open-flags)
[671.532148] Starting subtest: invalid-open-flags
[671.534580] Subtest invalid-open-flags: SUCCESS (0.000s)
[671.579458] [147/155] (356s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[671.686382] Starting subtest: yf-tiled-8bpp-rotate-0
[671.690928] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[671.812294] [148/155] (356s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[671.910923] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[671.914861] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[672.003254] [149/155] (356s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[672.115517] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[672.120087] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[672.234549] [150/155] (356s left) kms_cursor_crc (cursor-suspend)
[672.360534] Starting subtest: cursor-suspend
[672.362513] Starting dynamic subtest: pipe-A-eDP-1
[705.609988] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.169s)
[705.622747] Starting dynamic subtest: pipe-D-eDP-1
[739.593753] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.805s)
[739.596386] Subtest cursor-suspend: SUCCESS (6.977s)
[740.381005] [151/155] (288s left) gem_exec_suspend (basic)
[740.443480] Starting subtest: basic
[740.446390] Starting dynamic subtest: smem
[742.323409] Dynamic subtest smem: SUCCESS (1.923s)
[742.326627] Subtest basic: SUCCESS (1.925s)
[742.523061] [152/155] (286s left) kms_psr (fbc-psr2-primary-page-flip)
[742.622396] Starting subtest: fbc-psr2-primary-page-flip
[742.625186] Starting dynamic subtest: eDP-1
[742.630243] Dynamic subtest eDP-1: SKIP (0.000s)
[742.634578] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[742.697008] [153/155] (286s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[742.797898] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[742.802349] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[742.897666] [154/155] (285s left) i915_pm_rpm (sysfs-read)
[744.427588] Starting subtest: sysfs-read
[745.593826] Subtest sysfs-read: SUCCESS (1.184s)
[745.989975] [155/155] (282s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[746.088399] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[746.093326] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[746.200563] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_freq
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: i915_pm_freq_api
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_force_connector_basic
results: parsing output: 6/ for test: gem_ctx_shared
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_pipe_stress
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: prime_busy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_audio
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_media_vme
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_async_flips
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_sync
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: gem_render_copy_redux
results: parsing output: 47/ for test: gem_workarounds
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_wc
results: parsing output: 52/ for test: kms_dsc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_request_retire
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: dumb_buffer
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: gem_pread
results: parsing output: 65/ for test: gem_partial_pwrite_pread
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: kms_color_pipeline
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_sync
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: prime_self_import
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_setmode
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane_multiple
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_busy
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: gem_exec_suspend
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_joiner
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: i915_query
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: gem_busy
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: core_auth
results: parsing output: 114/ for test: kms_chamelium_frames
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_properties
results: parsing output: 122/ for test: gen7_exec_parse
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: kms_dp_aux_dev
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: gem_ctx_engines
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: gem_vm_create
results: parsing output: 133/ for test: gem_ctx_shared
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_panel_fitting
results: parsing output: 137/ for test: kms_tiled_display
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_rotation_crc
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_exec_params
results: parsing output: 142/ for test: kms_ccs
results: parsing output: 143/ for test: gem_exec_fence
results: parsing output: 144/ for test: kms_ccs
results: parsing output: 145/ for test: perf
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: gem_exec_suspend
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: i915_pm_rpm
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.