[90.546597] Initializing watchdogs
[90.546662]   /dev/watchdog0
[90.563554] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[90.569067] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.572112] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.573996] [001/155] (960s left) gem_ctx_freq (sysfs)
[90.617856] Starting subtest: sysfs
[90.618784] Starting dynamic subtest: gt0
[95.544509] Dynamic subtest gt0: SUCCESS (4.920s)
[95.545784] Subtest sysfs: SUCCESS (4.921s)
[95.634013] [002/155] (955s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[95.674402] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[95.675137] Starting dynamic subtest: smem
[95.780268] Dynamic subtest smem: SUCCESS (0.106s)
[95.781007] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.106s)
[95.973200] [003/155] (955s left) gem_exec_whisper (basic-queues-priority)
[96.018410] Starting subtest: basic-queues-priority
[98.282916] Subtest basic-queues-priority: SUCCESS (2.253s)
[98.454992] [004/155] (952s left) i915_pm_freq_api (freq-basic-api)
[98.491869] Subtest freq-basic-api: SKIP (0.000s)
[98.537559] [005/155] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[98.633336] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[98.634809] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.726979] [006/155] (952s left) kms_force_connector_basic (prune-stale-modes)
[98.848353] Starting subtest: prune-stale-modes
[98.997587] Subtest prune-stale-modes: SUCCESS (0.149s)
[99.149627] [007/155] (952s left) gem_ctx_shared (q-in-order)
[99.192827] Starting subtest: Q-in-order
[99.193549] Starting dynamic subtest: rcs0
[99.274318] Dynamic subtest rcs0: SUCCESS (0.081s)
[99.285398] Starting dynamic subtest: bcs0
[99.326056] Dynamic subtest bcs0: SUCCESS (0.051s)
[99.338365] Starting dynamic subtest: vcs0
[99.378179] Dynamic subtest vcs0: SUCCESS (0.051s)
[99.390683] Starting dynamic subtest: vcs1
[99.431086] Dynamic subtest vcs1: SUCCESS (0.052s)
[99.444607] Starting dynamic subtest: vecs0
[99.485477] Dynamic subtest vecs0: SUCCESS (0.054s)
[99.486622] Subtest Q-in-order: SUCCESS (0.292s)
[99.675212] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[99.676819] [008/155] (951s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[99.768999] Starting subtest: fbchdr-1p-rte
[99.770436] Subtest fbchdr-1p-rte: SKIP (0.000s)
[99.862109] [009/155] (951s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[99.954821] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[99.956225] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[100.053372] [010/155] (951s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[100.144037] Starting subtest: stress-xrgb8888-xtiled
[106.807680] Subtest stress-xrgb8888-xtiled: SUCCESS (6.660s)
[106.951732] [011/155] (944s left) kms_cursor_crc (cursor-random-32x10)
[107.048445] Starting subtest: cursor-random-32x10
[107.102770] Subtest cursor-random-32x10: SKIP (0.053s)
[107.215522] [012/155] (944s left) prime_busy (hang-wait)
[107.253483] Starting subtest: hang-wait
[107.254209] Starting dynamic subtest: rcs0
[120.442306] Dynamic subtest rcs0: SUCCESS (13.151s)
[120.458607] Starting dynamic subtest: bcs0
[127.545024] Dynamic subtest bcs0: SUCCESS (7.101s)
[127.555231] Starting dynamic subtest: vcs0
[134.559442] Dynamic subtest vcs0: SUCCESS (7.038s)
[134.570821] Starting dynamic subtest: vcs1
[141.562505] Dynamic subtest vcs1: SUCCESS (6.975s)
[141.572783] Starting dynamic subtest: vecs0
[148.601479] Dynamic subtest vecs0: SUCCESS (7.039s)
[148.602490] Subtest hang-wait: SUCCESS (41.308s)
[148.692567] [013/155] (902s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[148.786396] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[148.787876] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[148.887869] [014/155] (902s left) gem_mmap_offset (partial-mmap)
[148.920926] Starting subtest: partial-mmap
[148.921762] Starting dynamic subtest: smem0
[148.924128] Dynamic subtest smem0: SUCCESS (0.003s)
[148.924906] Subtest partial-mmap: SUCCESS (0.004s)
[149.027621] [015/155] (902s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[149.119110] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[149.120456] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[149.230451] [016/155] (902s left) syncobj_wait (multi-wait-submitted-signaled)
[149.264333] Starting subtest: multi-wait-submitted-signaled
[149.265051] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[149.341039] [017/155] (902s left) kms_psr (fbc-pr-cursor-render)
[149.428306] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[149.469355] [018/155] (902s left) gem_userptr_blits (stress-mm-invalidate-close)
[149.514454] Starting subtest: stress-mm-invalidate-close
[151.670856] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[151.778909] [019/155] (900s left) gem_exec_reloc (basic-cpu-read)
[151.815732] Starting subtest: basic-cpu-read
[151.821136] Subtest basic-cpu-read: SUCCESS (0.005s)
[151.932422] [020/155] (899s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[151.967445] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[152.069654] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[152.146783] [021/155] (899s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[152.238566] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[152.240007] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[152.334697] [022/155] (899s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[152.435865] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[152.437289] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[152.528647] [023/155] (899s left) syncobj_timeline (invalid-signal-bad-pad)
[152.563655] Starting subtest: invalid-signal-bad-pad
[152.564435] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[152.633126] [024/155] (899s left) kms_content_protection (lic-type-0)
[152.724164] Starting subtest: lic-type-0
[152.729712] Subtest lic-type-0: SKIP (0.003s)
[152.828765] [025/155] (899s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[152.926238] Starting subtest: 4-tiled-64bpp-rotate-270
[152.927635] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[153.029713] [026/155] (899s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[153.122100] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[153.123438] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[153.227864] [027/155] (898s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[153.321421] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[153.322807] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[153.431035] [028/155] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[153.524169] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[153.525541] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[153.630796] [029/155] (898s left) kms_chamelium_audio (dp-audio-edid)
[153.776187] Subtest dp-audio-edid: SKIP (0.000s)
[153.879552] [030/155] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[153.978357] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[153.979735] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[154.069764] [031/155] (898s left) gem_softpin (evict-prime-sanity-check)
[154.106409] Starting subtest: evict-prime-sanity-check
[154.107136] Starting dynamic subtest: rcs0
[155.222763] Dynamic subtest rcs0: SUCCESS (1.116s)
[155.234046] Starting dynamic subtest: bcs0
[156.337946] Dynamic subtest bcs0: SUCCESS (1.114s)
[156.353392] Starting dynamic subtest: vcs0
[157.454655] Dynamic subtest vcs0: SUCCESS (1.116s)
[157.465683] Starting dynamic subtest: vcs1
[158.567878] Dynamic subtest vcs1: SUCCESS (1.112s)
[158.578815] Starting dynamic subtest: vecs0
[159.680867] Dynamic subtest vecs0: SUCCESS (1.112s)
[159.697125] Starting dynamic subtest: all
[160.795790] Dynamic subtest all: SUCCESS (1.114s)
[160.796970] Subtest evict-prime-sanity-check: SUCCESS (6.689s)
[160.867481] [032/155] (891s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[160.958461] Starting subtest: basic-flip-after-cursor-legacy
[161.468775] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.509s)
[161.631705] [033/155] (890s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[161.723748] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[161.724478] Starting dynamic subtest: pipe-A-HDMI-A-1
[161.731313] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[161.738835] Starting dynamic subtest: pipe-B-HDMI-A-1
[161.745842] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[161.753206] Starting dynamic subtest: pipe-C-HDMI-A-1
[161.760052] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[161.774333] Starting dynamic subtest: pipe-D-HDMI-A-1
[161.781837] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[161.783311] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[161.968843] [034/155] (890s left) api_intel_allocator (reloc-allocator)
[162.002694] Starting subtest: reloc-allocator
[162.003376] Starting dynamic subtest: basic
[162.005216] Dynamic subtest basic: SUCCESS (0.003s)
[162.013310] Starting dynamic subtest: parallel-one
[162.014057] Dynamic subtest parallel-one: SUCCESS (0.005s)
[162.022247] Starting dynamic subtest: print
[162.023024] Dynamic subtest print: SUCCESS (0.000s)
[162.030833] Starting dynamic subtest: reuse
[162.031541] Dynamic subtest reuse: SUCCESS (0.000s)
[162.038863] Starting dynamic subtest: fork-reopen-allocator
[162.039584] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[162.040266] Subtest reloc-allocator: SUCCESS (0.025s)
[162.124534] [035/155] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[162.217173] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[162.218530] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[162.309919] [036/155] (890s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[162.396589] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[162.397979] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[162.451445] [037/155] (890s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[162.542199] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[162.543588] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[162.647590] [038/155] (889s left) gem_media_vme
[162.730804] [039/155] (889s left) gem_exec_reloc (basic-wc-noreloc)
[162.768202] Starting subtest: basic-wc-noreloc
[162.771086] Subtest basic-wc-noreloc: SUCCESS (0.003s)
[162.891785] [040/155] (889s left) kms_async_flips (test-time-stamp-atomic)
[162.978788] Starting subtest: test-time-stamp-atomic
[163.095599] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.219440] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.123s)
[163.357223] Starting dynamic subtest: pipe-B-HDMI-A-1
[163.456240] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.108s)
[163.580071] Starting dynamic subtest: pipe-C-HDMI-A-1
[163.668374] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.096s)
[163.788261] Starting dynamic subtest: pipe-D-HDMI-A-1
[163.884455] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.104s)
[163.885183] Subtest test-time-stamp-atomic: SUCCESS (0.906s)
[164.123992] [041/155] (888s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[164.165379] Starting subtest: mixed-tiled-to-y-tiled-ccs
[164.166132] Starting dynamic subtest: smem
[164.275390] Dynamic subtest smem: SUCCESS (0.110s)
[164.276165] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.110s)
[164.460760] [042/155] (888s left) kms_rotation_crc (multiplane-rotation)
[164.553725] Starting subtest: multiplane-rotation
[190.754892] Subtest multiplane-rotation: SUCCESS (26.203s)
[190.863937] [043/155] (861s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[190.963073] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[190.963819] Starting dynamic subtest: pipe-A-valid-mode
[191.975885] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.012s)
[191.976700] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.014s)
[192.136966] [044/155] (860s left) gem_sync (basic-all)
[192.184656] Starting subtest: basic-all
[194.452133] Subtest basic-all: SUCCESS (2.267s)
[194.631692] [045/155] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[194.726773] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[196.066388] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.340s)
[196.209202] [046/155] (856s left) gem_exec_flush (basic-wb-pro-default)
[196.253914] Starting subtest: basic-wb-pro-default
[201.685135] Subtest basic-wb-pro-default: SUCCESS (5.432s)
[201.896120] [047/155] (851s left) gem_render_copy_redux (interruptible)
[201.934231] Starting subtest: interruptible
[202.284262] Subtest interruptible: SUCCESS (0.341s)
[202.392220] [048/155] (850s left) gem_workarounds (reset)
[202.440369] Starting subtest: reset
[202.451210] Subtest reset: SUCCESS (0.010s)
[202.554311] [049/155] (850s left) perf (polling-parameterized)
[202.643101] Starting subtest: polling-parameterized
[222.695616] Subtest polling-parameterized: SUCCESS (20.018s)
[222.761091] [050/155] (830s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[222.867776] Starting subtest: hdr-2p-pri-indfb-multidraw
[222.869247] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[222.958119] [051/155] (830s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[223.052427] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[223.053856] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[223.149738] [052/155] (830s left) gem_mmap_wc (read-write)
[223.183033] Starting subtest: read-write
[223.185681] Subtest read-write: SUCCESS (0.003s)
[223.274134] [053/155] (829s left) kms_dsc (dsc-fractional-bpp)
[223.366360] Starting subtest: dsc-fractional-bpp
[223.370555] Subtest dsc-fractional-bpp: SKIP (0.000s)
[223.424720] [054/155] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[223.518425] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[223.519796] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[223.617405] [055/155] (829s left) gem_request_retire (retire-vma-not-inactive)
[223.654345] Starting subtest: retire-vma-not-inactive
[223.666267] Subtest retire-vma-not-inactive: SUCCESS (0.011s)
[223.787383] [056/155] (829s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[223.878301] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[223.879023] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.896534] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[223.904224] Starting dynamic subtest: pipe-B-HDMI-A-1
[223.921919] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[223.929405] Starting dynamic subtest: pipe-C-HDMI-A-1
[223.946556] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[223.954354] Starting dynamic subtest: pipe-D-HDMI-A-1
[223.971905] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[223.973311] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s)
[224.135382] [057/155] (829s left) api_intel_bb (simple-bb)
[224.172346] Starting subtest: simple-bb
[224.174242] Subtest simple-bb: SUCCESS (0.003s)
[224.289219] [058/155] (829s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[224.389621] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[224.990518] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.601s)
[225.110904] [059/155] (828s left) dumb_buffer (create-valid-dumb)
[225.145069] Starting subtest: create-valid-dumb
[225.145846] Subtest create-valid-dumb: SUCCESS (0.000s)
[225.235105] [060/155] (828s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[225.337556] Starting subtest: y-tiled-8bpp-rotate-180
[226.340636] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.004s)
[226.481375] [061/155] (827s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[226.574044] Starting subtest: plane-primary-toggle-with-vblank-wait
[226.574802] Starting dynamic subtest: pipe-A-HDMI-A-1
[226.690239] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.115s)
[226.761569] Starting dynamic subtest: pipe-B-HDMI-A-1
[226.932977] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.181s)
[226.982995] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.408s)
[227.145224] [062/155] (826s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[227.247855] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[227.249354] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[227.360208] [063/155] (826s left) gem_exec_reloc (basic-scanout)
[227.455944] Starting subtest: basic-scanout
[227.456678] Starting dynamic subtest: rcs0
[227.602120] Dynamic subtest rcs0: SUCCESS (0.146s)
[227.613319] Starting dynamic subtest: bcs0
[227.727516] Dynamic subtest bcs0: SUCCESS (0.124s)
[227.745833] Starting dynamic subtest: vcs0
[227.852131] Dynamic subtest vcs0: SUCCESS (0.122s)
[227.867737] Starting dynamic subtest: vcs1
[227.977368] Dynamic subtest vcs1: SUCCESS (0.124s)
[227.995291] Starting dynamic subtest: vecs0
[228.102466] Dynamic subtest vecs0: SUCCESS (0.123s)
[228.103409] Subtest basic-scanout: SUCCESS (0.648s)
[228.227777] [064/155] (825s left) perf_pmu (busy-accuracy-98)
[228.266345] Starting subtest: busy-accuracy-98
[228.267103] Starting dynamic subtest: rcs0
[231.293978] Dynamic subtest rcs0: SUCCESS (3.025s)
[231.302173] Starting dynamic subtest: bcs0
[234.319613] Dynamic subtest bcs0: SUCCESS (3.024s)
[234.328279] Starting dynamic subtest: vcs0
[237.346639] Dynamic subtest vcs0: SUCCESS (3.026s)
[237.355832] Starting dynamic subtest: vcs1
[240.373664] Dynamic subtest vcs1: SUCCESS (3.026s)
[240.383021] Starting dynamic subtest: vecs0
[243.401433] Dynamic subtest vecs0: SUCCESS (3.026s)
[243.402379] Subtest busy-accuracy-98: SUCCESS (15.133s)
[243.489816] [065/155] (810s left) gem_pread (display)
[243.525178] Starting subtest: display
[244.354553] Subtest display: SUCCESS (0.821s)
[244.430778] [066/155] (809s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[244.475875] Starting subtest: writes-after-reads-uncached
[256.750290] Subtest writes-after-reads-uncached: SUCCESS (12.282s)
[256.854126] [067/155] (796s left) gem_softpin (softpin)
[256.894443] Starting subtest: softpin
[289.132847] Subtest softpin: SUCCESS (32.228s)
[289.240641] [068/155] (764s left) kms_addfb_basic (invalid-get-prop-any)
[289.275961] Starting subtest: invalid-get-prop-any
[289.276673] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[289.436460] [069/155] (764s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[289.582043] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[289.688178] [070/155] (764s left) kms_pm_rpm (i2c)
[291.085944] Starting subtest: i2c
[293.880378] Subtest i2c: SUCCESS (2.793s)
[294.009771] [071/155] (760s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[294.104162] Starting subtest: plane-lut1d-pre-ctm3x4
[294.194030] Starting dynamic subtest: pipe-A-plane-0
[294.301834] Dynamic subtest pipe-A-plane-0: SUCCESS (0.108s)
[294.318440] Starting dynamic subtest: pipe-A-plane-1
[294.393394] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[294.408612] Starting dynamic subtest: pipe-A-plane-2
[294.493338] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s)
[294.731052] Starting dynamic subtest: pipe-B-plane-0
[294.813192] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[294.826017] Starting dynamic subtest: pipe-B-plane-1
[294.913441] Dynamic subtest pipe-B-plane-1: SUCCESS (0.098s)
[294.928593] Starting dynamic subtest: pipe-B-plane-2
[295.005468] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[295.224238] Starting dynamic subtest: pipe-C-plane-0
[295.299901] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[295.318241] Starting dynamic subtest: pipe-C-plane-1
[295.408228] Dynamic subtest pipe-C-plane-1: SUCCESS (0.106s)
[295.422409] Starting dynamic subtest: pipe-C-plane-2
[295.508161] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s)
[295.723799] Starting dynamic subtest: pipe-D-plane-0
[295.814968] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s)
[295.831095] Starting dynamic subtest: pipe-D-plane-1
[295.914864] Dynamic subtest pipe-D-plane-1: SUCCESS (0.096s)
[295.930435] Starting dynamic subtest: pipe-D-plane-2
[296.014940] Dynamic subtest pipe-D-plane-2: SUCCESS (0.096s)
[296.063897] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (1.959s)
[296.179085] [072/155] (757s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[296.275128] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[296.275854] Starting dynamic subtest: pipe-A
[296.407326] Dynamic subtest pipe-A: SUCCESS (0.132s)
[296.416753] Starting dynamic subtest: pipe-B
[296.566632] Dynamic subtest pipe-B: SUCCESS (0.158s)
[296.584398] Starting dynamic subtest: pipe-C
[296.709321] Dynamic subtest pipe-C: SUCCESS (0.142s)
[296.727317] Starting dynamic subtest: pipe-D
[296.867813] Dynamic subtest pipe-D: SUCCESS (0.157s)
[296.868568] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.594s)
[297.064698] [073/155] (757s left) gem_exec_balancer (sliced)
[297.109542] Starting subtest: sliced
[298.570095] Subtest sliced: SUCCESS (1.452s)
[298.748127] [074/155] (755s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[298.845202] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[298.846722] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.915850] [075/155] (755s left) gem_sync (basic-store-each)
[298.961154] Starting subtest: basic-store-each
[301.131103] Subtest basic-store-each: SUCCESS (2.170s)
[301.326732] [076/155] (752s left) kms_psr (pr-cursor-mmap-gtt)
[301.417941] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[301.460352] [077/155] (752s left) kms_psr (psr2-sprite-render)
[301.550066] Subtest psr2-sprite-render: SKIP (0.000s)
[301.594769] [078/155] (752s left) prime_self_import (basic-with_two_bos)
[301.628165] Starting subtest: basic-with_two_bos
[301.630830] Subtest basic-with_two_bos: SUCCESS (0.003s)
[301.735623] [079/155] (752s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[301.824069] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[301.825818] Starting dynamic subtest: pipe-A-valid-mode
[302.877783] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.052s)
[302.878535] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (1.054s)
[303.040345] [080/155] (751s left) kms_setmode (basic)
[303.077586] Starting subtest: basic
[303.157376] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.246841] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.079s)
[304.309777] Starting dynamic subtest: pipe-B-HDMI-A-1
[305.388190] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.076s)
[305.427486] Subtest basic: SUCCESS (2.349s)
[305.597566] [081/155] (748s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[305.696171] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[305.697608] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[305.785869] [082/155] (748s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[305.820793] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[305.926192] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[306.004995] [083/155] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[306.099469] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[306.100882] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[306.196138] [084/155] (748s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[306.289528] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[306.290960] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[306.390351] [085/155] (748s left) kms_plane_multiple (tiling-none)
[306.479152] Starting subtest: tiling-none
[306.479857] Starting dynamic subtest: pipe-A-HDMI-A-1
[307.086967] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.607s)
[307.099279] Starting dynamic subtest: pipe-B-HDMI-A-1
[307.729671] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.641s)
[307.741179] Starting dynamic subtest: pipe-C-HDMI-A-1
[308.315342] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.584s)
[308.326109] Starting dynamic subtest: pipe-D-HDMI-A-1
[308.927348] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.609s)
[308.929267] Subtest tiling-none: SUCCESS (2.450s)
[309.105548] [086/155] (745s left) gem_userptr_blits (unsync-overlap)
[309.150750] Subtest unsync-overlap: SKIP (0.000s)
[309.260955] [087/155] (745s left) kms_busy (extended-modeset-hang-newfb)
[309.356950] Starting subtest: extended-modeset-hang-newfb
[309.357698] Starting dynamic subtest: pipe-A
[334.034432] Dynamic subtest pipe-A: SUCCESS (24.676s)
[334.044923] Starting dynamic subtest: pipe-D
[358.086182] Dynamic subtest pipe-D: SUCCESS (24.049s)
[358.088591] Subtest extended-modeset-hang-newfb: SUCCESS (48.732s)
[358.239793] [088/155] (696s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[358.335038] Starting subtest: cursorA-vs-flipB-toggle
[358.336405] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[358.394774] [089/155] (696s left) gem_mmap_wc (bad-object)
[358.428777] Starting subtest: bad-object
[358.429474] Subtest bad-object: SUCCESS (0.000s)
[358.521661] [090/155] (696s left) kms_vblank (wait-forked-busy)
[358.611198] Starting subtest: wait-forked-busy
[358.611954] Starting dynamic subtest: pipe-A-HDMI-A-1
[359.875888] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.264s)
[359.890605] Starting dynamic subtest: pipe-D-HDMI-A-1
[361.155276] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.275s)
[361.155979] Subtest wait-forked-busy: SUCCESS (2.545s)
[361.320934] [091/155] (693s left) gem_exec_schedule (preemptive-hang)
[361.489771] Starting subtest: preemptive-hang
[361.490874] Starting dynamic subtest: rcs0
[368.025453] Dynamic subtest rcs0: SUCCESS (6.510s)
[368.033330] Starting dynamic subtest: bcs0
[374.033301] Dynamic subtest bcs0: SUCCESS (6.005s)
[374.041548] Starting dynamic subtest: vcs0
[380.049395] Dynamic subtest vcs0: SUCCESS (6.014s)
[380.058172] Starting dynamic subtest: vcs1
[386.065347] Dynamic subtest vcs1: SUCCESS (6.012s)
[386.073350] Starting dynamic subtest: vecs0
[392.025753] Dynamic subtest vecs0: SUCCESS (5.958s)
[392.026729] Subtest preemptive-hang: SUCCESS (30.511s)
[392.185414] [092/155] (662s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[392.290750] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[392.292110] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[392.384911] [093/155] (662s left) gem_exec_schedule (submit-late-slice)
[392.431058] Starting subtest: submit-late-slice
[392.431837] Starting dynamic subtest: rcs0
[392.457033] Dynamic subtest rcs0: SUCCESS (0.025s)
[392.466849] Starting dynamic subtest: bcs0
[392.480979] Dynamic subtest bcs0: SUCCESS (0.023s)
[392.491476] Starting dynamic subtest: vcs0
[392.507979] Dynamic subtest vcs0: SUCCESS (0.026s)
[392.517986] Starting dynamic subtest: vcs1
[392.532956] Dynamic subtest vcs1: SUCCESS (0.024s)
[392.543104] Starting dynamic subtest: vecs0
[392.563096] Dynamic subtest vecs0: SUCCESS (0.029s)
[392.563921] Subtest submit-late-slice: SUCCESS (0.132s)
[392.862873] [094/155] (662s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[392.897996] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[392.898698] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[392.979103] [095/155] (662s left) kms_psr (psr2-cursor-mmap-gtt)
[393.067792] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[393.109185] [096/155] (661s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[393.199170] Starting subtest: async-flip-with-page-flip-events-tiled
[393.320918] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs
[395.488518] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs: SUCCESS (2.159s)
[395.501992] Starting dynamic subtest: pipe-A-HDMI-A-1-y
[397.569384] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.079s)
[397.581313] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[399.611185] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.041s)
[399.754131] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs
[401.903553] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs: SUCCESS (2.151s)
[401.915210] Starting dynamic subtest: pipe-B-HDMI-A-1-y
[403.967998] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.063s)
[403.978682] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[406.001741] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.033s)
[406.113490] Starting dynamic subtest: pipe-C-HDMI-A-1-y-rc-ccs
[408.284812] Dynamic subtest pipe-C-HDMI-A-1-y-rc-ccs: SUCCESS (2.171s)
[408.294418] Starting dynamic subtest: pipe-C-HDMI-A-1-y
[410.349825] Dynamic subtest pipe-C-HDMI-A-1-y: SUCCESS (2.064s)
[410.358955] Starting dynamic subtest: pipe-C-HDMI-A-1-x
[412.383603] Dynamic subtest pipe-C-HDMI-A-1-x: SUCCESS (2.032s)
[412.492817] Starting dynamic subtest: pipe-D-HDMI-A-1-y-rc-ccs
[414.644361] Dynamic subtest pipe-D-HDMI-A-1-y-rc-ccs: SUCCESS (2.151s)
[414.656460] Starting dynamic subtest: pipe-D-HDMI-A-1-y
[416.717557] Dynamic subtest pipe-D-HDMI-A-1-y: SUCCESS (2.072s)
[416.731676] Starting dynamic subtest: pipe-D-HDMI-A-1-x
[418.751116] Dynamic subtest pipe-D-HDMI-A-1-x: SUCCESS (2.032s)
[418.751851] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (25.544s)
[418.989162] [097/155] (636s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[419.091452] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[419.092849] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[419.179895] [098/155] (635s left) kms_getfb (getfb2-handle-protection)
[419.271343] Starting subtest: getfb2-handle-protection
[419.284992] Subtest getfb2-handle-protection: SUCCESS (0.014s)
[419.400201] [099/155] (635s left) gem_exec_suspend (basic-s0)
[419.442967] Starting subtest: basic-S0
[419.443752] Starting dynamic subtest: smem
[436.990789] Dynamic subtest smem: SUCCESS (2.650s)
[436.991581] Subtest basic-S0: SUCCESS (2.651s)
[445.205275] [100/155] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[445.307395] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[445.308866] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[445.434038] [101/155] (617s left) kms_joiner (basic-force-ultra-joiner)
[445.529885] Starting subtest: basic-force-ultra-joiner
[445.531284] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[445.597432] [102/155] (617s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[445.689959] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[445.690670] Starting dynamic subtest: pipe-A
[446.927430] Dynamic subtest pipe-A: SUCCESS (1.206s)
[446.940044] Starting dynamic subtest: pipe-B
[448.248686] Dynamic subtest pipe-B: SUCCESS (1.275s)
[448.257855] Starting dynamic subtest: pipe-C
[448.445286] Dynamic subtest pipe-C: SUCCESS (0.208s)
[448.458894] Starting dynamic subtest: pipe-D
[448.658227] Dynamic subtest pipe-D: SUCCESS (0.208s)
[448.658987] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.901s)
[448.857933] [103/155] (614s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[448.895391] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[449.000411] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[449.078348] [104/155] (614s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[449.174448] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[449.175889] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[449.274840] [105/155] (614s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[449.370488] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[449.371927] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[449.481759] [106/155] (614s left) gem_exec_params (dr4-dirt)
[449.519268] Starting subtest: DR4-dirt
[449.520016] Subtest DR4-dirt: SUCCESS (0.000s)
[449.626673] [107/155] (613s left) i915_query (engine-info-invalid)
[449.661629] Starting subtest: engine-info-invalid
[449.662486] Subtest engine-info-invalid: SUCCESS (0.000s)
[449.742802] [108/155] (613s left) syncobj_wait (invalid-reset-bad-pad)
[449.779601] Starting subtest: invalid-reset-bad-pad
[449.780338] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[449.857927] [109/155] (613s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[449.952546] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[451.648075] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (1.671s)
[451.768859] [110/155] (611s left) syncobj_wait (reset-signaled)
[451.804139] Starting subtest: reset-signaled
[451.804915] Subtest reset-signaled: SUCCESS (0.000s)
[451.876689] [111/155] (611s left) kms_lease (multimaster-lease)
[451.966887] Starting subtest: multimaster-lease
[451.970017] Subtest multimaster-lease: SUCCESS (0.003s)
[452.031889] [112/155] (611s left) gem_busy (semaphore)
[452.210012] Starting subtest: semaphore
[452.210929] Starting dynamic subtest: rcs0
[452.244043] Dynamic subtest rcs0: SUCCESS (0.038s)
[452.261898] Starting dynamic subtest: bcs0
[452.268789] Dynamic subtest bcs0: SUCCESS (0.022s)
[452.280834] Starting dynamic subtest: vcs0
[452.287673] Dynamic subtest vcs0: SUCCESS (0.017s)
[452.298547] Starting dynamic subtest: vcs1
[452.310679] Dynamic subtest vcs1: SUCCESS (0.021s)
[452.323266] Starting dynamic subtest: vecs0
[452.331850] Dynamic subtest vecs0: SUCCESS (0.019s)
[452.332699] Subtest semaphore: SUCCESS (0.126s)
[452.572674] [113/155] (611s left) vgem_basic (setversion)
[452.609523] Starting subtest: setversion
[452.611527] Subtest setversion: SUCCESS (0.000s)
[452.677875] [114/155] (611s left) core_auth (many-magics)
[452.712516] Starting subtest: many-magics
[453.293989] Subtest many-magics: SUCCESS (0.574s)
[453.409399] [115/155] (610s left) kms_chamelium_frames (dp-crc-fast)
[453.555591] Subtest dp-crc-fast: SKIP (0.000s)
[453.662739] [116/155] (610s left) gem_exec_reloc (basic-cpu-read-active)
[453.705407] Starting subtest: basic-cpu-read-active
[453.836966] Subtest basic-cpu-read-active: SUCCESS (0.120s)
[453.951850] [117/155] (610s left) kms_pm_rpm (modeset-non-lpsp-stress)
[455.353168] Starting subtest: modeset-non-lpsp-stress
[456.551361] Subtest modeset-non-lpsp-stress: SKIP (1.188s)
[456.743383] [118/155] (607s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[456.780554] Starting subtest: single-wait-for-submit-available-submitted
[456.781273] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[456.859577] [119/155] (607s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[456.951427] Starting subtest: 2x-plain-flip-ts-check-interruptible
[456.961092] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.009s)
[457.040805] [120/155] (607s left) i915_drm_fdinfo (busy-hang)
[457.078008] Starting subtest: busy-hang
[457.078854] Starting dynamic subtest: rcs0
[458.110425] Dynamic subtest rcs0: SUCCESS (1.025s)
[458.122526] Starting dynamic subtest: bcs0
[459.143219] Dynamic subtest bcs0: SUCCESS (1.023s)
[459.155038] Starting dynamic subtest: vcs0
[460.176477] Dynamic subtest vcs0: SUCCESS (1.026s)
[460.188813] Starting dynamic subtest: vcs1
[461.208154] Dynamic subtest vcs1: SUCCESS (1.024s)
[461.219693] Starting dynamic subtest: vecs0
[462.238401] Dynamic subtest vecs0: SUCCESS (1.021s)
[462.239652] Subtest busy-hang: SUCCESS (5.134s)
[462.309161] [121/155] (601s left) kms_cursor_crc (cursor-offscreen-256x85)
[462.405039] Starting subtest: cursor-offscreen-256x85
[462.408775] Starting dynamic subtest: pipe-A-HDMI-A-1
[463.652569] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.239s)
[463.690796] Starting dynamic subtest: pipe-D-HDMI-A-1
[464.906295] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.221s)
[464.907078] Subtest cursor-offscreen-256x85: SUCCESS (2.495s)
[465.067795] [122/155] (599s left) kms_properties (connector-properties-legacy)
[465.160685] Starting subtest: connector-properties-legacy
[465.162597] Starting dynamic subtest: pipe-A-HDMI-A-1
[465.772302] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.608s)
[465.785769] Starting dynamic subtest: pipe-None-DP-1
[465.787291] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[465.796494] Starting dynamic subtest: pipe-None-DP-2
[465.797905] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[465.806878] Starting dynamic subtest: pipe-None-DP-3
[465.808323] Dynamic subtest pipe-None-DP-3: SUCCESS (0.006s)
[465.817422] Starting dynamic subtest: pipe-None-DP-4
[465.818813] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[465.819520] Subtest connector-properties-legacy: SUCCESS (0.629s)
[465.914296] [123/155] (598s left) gen7_exec_parse (bitmasks)
[465.954130] Subtest bitmasks: SKIP (0.000s)
[466.000585] [124/155] (598s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[466.093138] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[466.094636] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[466.197828] [125/155] (598s left) kms_prop_blob (invalid-set-prop-any)
[466.234410] Starting subtest: invalid-set-prop-any
[466.235151] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[466.305489] [126/155] (598s left) kms_dp_aux_dev (basic)
[466.339724] Starting subtest: basic
[466.576150] Subtest basic: SKIP (0.234s)
[466.651489] [127/155] (597s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[466.743183] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[466.744557] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.837727] [128/155] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[466.929891] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[466.931385] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.029516] [129/155] (597s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[467.125224] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[467.170926] [130/155] (597s left) gem_exec_balancer (individual)
[467.213088] Starting subtest: individual
[468.796625] Subtest individual: SUCCESS (1.572s)
[468.987495] [131/155] (595s left) gem_ctx_engines (execute-one)
[469.030839] Starting subtest: execute-one
[470.302771] Subtest execute-one: SUCCESS (1.262s)
[470.477063] [132/155] (594s left) gem_userptr_blits (process-exit-busy)
[470.522841] Starting subtest: process-exit-busy
[470.538350] Subtest process-exit-busy: SUCCESS (0.016s)
[470.649903] [133/155] (594s left) gem_vm_create (invalid-create)
[470.688550] Starting subtest: invalid-create
[470.689284] Subtest invalid-create: SUCCESS (0.001s)
[470.795084] [134/155] (593s left) gem_ctx_shared (detached-shared-gtt)
[470.837593] Starting subtest: detached-shared-gtt
[472.995843] Subtest detached-shared-gtt: SUCCESS (2.149s)
[473.173449] [135/155] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[473.268441] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[473.269847] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[473.360026] [136/155] (591s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[473.455883] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[473.457349] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[473.551860] [137/155] (591s left) kms_panel_fitting (legacy)
[473.640004] Starting subtest: legacy
[473.641530] Subtest legacy: SKIP (0.000s)
[473.708527] [138/155] (591s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[473.832682] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[473.889853] [139/155] (591s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[473.983615] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[473.985079] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[474.071262] [140/155] (590s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[474.162810] Starting subtest: sprite-rotation-90-pos-100-0
[479.111335] Subtest sprite-rotation-90-pos-100-0: SUCCESS (4.948s)
[479.329410] [141/155] (585s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[479.425084] Starting subtest: hdr-rgb101010-draw-render
[479.426562] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[479.537682] [142/155] (585s left) gem_exec_params (invalid-bsd-ring)
[479.575673] Starting subtest: invalid-bsd-ring
[479.576438] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[479.678098] [143/155] (585s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[479.766695] Starting subtest: crc-primary-suspend-y-tiled-ccs
[479.767490] Starting dynamic subtest: pipe-A-HDMI-A-1
[479.770191] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[479.779327] Starting dynamic subtest: pipe-B-HDMI-A-1
[479.782095] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[479.791011] Starting dynamic subtest: pipe-C-HDMI-A-1
[479.793752] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[479.802476] Starting dynamic subtest: pipe-D-HDMI-A-1
[479.805204] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[479.806583] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.007s)
[480.019817] [144/155] (585s left) gem_exec_fence (nb-await)
[480.185494] Starting subtest: nb-await
[480.186539] Starting dynamic subtest: rcs0
[480.247116] Dynamic subtest rcs0: SUCCESS (0.061s)
[480.266687] Starting dynamic subtest: bcs0
[480.313900] Dynamic subtest bcs0: SUCCESS (0.064s)
[480.333867] Starting dynamic subtest: vcs0
[480.379963] Dynamic subtest vcs0: SUCCESS (0.064s)
[480.400321] Starting dynamic subtest: vcs1
[480.446585] Dynamic subtest vcs1: SUCCESS (0.064s)
[480.466451] Starting dynamic subtest: vecs0
[480.512626] Dynamic subtest vecs0: SUCCESS (0.063s)
[480.513981] Subtest nb-await: SUCCESS (0.328s)
[480.998147] [145/155] (584s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[481.088994] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[481.089718] Starting dynamic subtest: pipe-A-HDMI-A-1
[481.096498] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[481.105729] Starting dynamic subtest: pipe-B-HDMI-A-1
[481.112544] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[481.122116] Starting dynamic subtest: pipe-C-HDMI-A-1
[481.128882] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[481.137672] Starting dynamic subtest: pipe-D-HDMI-A-1
[481.145053] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[481.146394] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[481.337861] [146/155] (583s left) perf (invalid-open-flags)
[481.428182] Starting subtest: invalid-open-flags
[481.428996] Subtest invalid-open-flags: SUCCESS (0.000s)
[481.472648] [147/155] (583s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[481.570283] Starting subtest: yf-tiled-8bpp-rotate-0
[481.571701] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[481.676593] [148/155] (583s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[481.770222] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[481.771658] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[481.876813] [149/155] (583s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[481.969212] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[481.970615] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[482.076857] [150/155] (583s left) kms_cursor_crc (cursor-suspend)
[482.166817] Starting subtest: cursor-suspend
[482.168579] Starting dynamic subtest: pipe-A-HDMI-A-1
[514.680587] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.861s)
[514.693306] Starting dynamic subtest: pipe-D-HDMI-A-1
[547.656764] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.797s)
[547.657552] Subtest cursor-suspend: SUCCESS (5.662s)
[555.858968] [151/155] (517s left) gem_exec_suspend (basic)
[555.901715] Starting subtest: basic
[555.902541] Starting dynamic subtest: smem
[556.384650] Dynamic subtest smem: SUCCESS (0.469s)
[556.385459] Subtest basic: SUCCESS (0.470s)
[556.590399] [152/155] (516s left) kms_psr (fbc-psr2-primary-page-flip)
[556.684406] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[556.734610] [153/155] (516s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[556.829280] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[556.830695] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[556.904872] [154/155] (516s left) i915_pm_rpm (sysfs-read)
[558.305606] Starting subtest: sysfs-read
[559.509200] Subtest sysfs-read: SUCCESS (1.175s)
[559.689995] [155/155] (513s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[559.785790] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[559.787276] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[559.885970] 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.