[58.422659] Initializing watchdogs
[58.422704]   /dev/watchdog0
[58.437380] [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]
[58.441952] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.444541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.447857] [001/156] (960s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[58.567161] Starting subtest: fbc-dirtyfb-ioctl
[58.569447] Starting dynamic subtest: A-eDP-1
[61.230608] Dynamic subtest A-eDP-1: SUCCESS (2.631s)
[61.233258] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.632s)
[62.045170] [002/156] (956s left) gem_exec_fence (syncobj-wait)
[62.489924] Starting subtest: syncobj-wait
[64.345448] Subtest syncobj-wait: SUCCESS (1.842s)
[64.692661] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[64.695790] [003/156] (954s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[64.799974] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[64.804271] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[64.920551] [004/156] (954s left) kms_getfb (getfb-reject-nv12)
[65.004693] Starting subtest: getfb-reject-nv12
[65.007101] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[65.091079] [005/156] (954s left) kms_vblank (wait-busy-hang)
[65.183522] Starting subtest: wait-busy-hang
[65.185447] Starting dynamic subtest: pipe-A-eDP-1
[92.104786] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.874s)
[92.120147] Starting dynamic subtest: pipe-D-eDP-1
[117.069236] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[117.071573] Subtest wait-busy-hang: SUCCESS (51.837s)
[117.879165] [006/156] (901s left) gem_ccs (block-copy-uncompressed)
[117.937399] Starting subtest: block-copy-uncompressed
[117.939859] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[117.959568] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[117.971666] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[117.977406] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[117.985577] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[117.995504] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[118.005464] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[118.014110] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[118.016398] Subtest block-copy-uncompressed: SUCCESS (0.077s)
[118.143805] [007/156] (901s left) gem_media_fill (media-fill)
[118.212412] Subtest media-fill: SKIP (0.000s)
[118.339604] [008/156] (900s left) i915_drm_fdinfo (isolation)
[118.380068] Starting subtest: isolation
[118.382150] Starting dynamic subtest: rcs0
[118.404157] Dynamic subtest rcs0: SKIP (0.023s)
[118.413636] Starting dynamic subtest: bcs0
[118.417785] Dynamic subtest bcs0: SKIP (0.000s)
[118.425627] Starting dynamic subtest: vcs0
[118.430090] Dynamic subtest vcs0: SKIP (0.000s)
[118.437729] Starting dynamic subtest: vcs1
[118.441844] Dynamic subtest vcs1: SKIP (0.001s)
[118.448826] Starting dynamic subtest: vecs0
[118.453039] Dynamic subtest vecs0: SKIP (0.001s)
[118.460636] Starting dynamic subtest: ccs0
[118.464817] Dynamic subtest ccs0: SKIP (0.001s)
[118.468989] Subtest isolation: SKIP (0.028s)
[118.504941] [009/156] (900s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[118.610041] Starting subtest: yf-tiled-8bpp-rotate-270
[118.614505] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[118.699354] [010/156] (900s left) core_auth (getclient-master-drop)
[118.732063] Starting subtest: getclient-master-drop
[118.757059] Subtest getclient-master-drop: SUCCESS (0.026s)
[118.867850] [011/156] (900s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[118.969277] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[118.972781] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[119.046852] [012/156] (900s left) gem_reg_read (bad-register)
[119.101160] Starting subtest: bad-register
[119.103114] Subtest bad-register: SUCCESS (0.000s)
[119.224187] [013/156] (900s left) prime_self_import (basic-llseek-bad)
[119.256087] Starting subtest: basic-llseek-bad
[119.273932] Subtest basic-llseek-bad: SUCCESS (0.015s)
[119.371210] [014/156] (900s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[119.480384] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[119.484317] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.593765] [015/156] (899s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[119.687764] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[119.689953] Starting dynamic subtest: pipe-A-eDP-1
[119.710251] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.720141] Starting dynamic subtest: pipe-B-eDP-1
[119.738521] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.745788] Starting dynamic subtest: pipe-C-eDP-1
[119.763883] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.770984] Starting dynamic subtest: pipe-D-eDP-1
[119.789672] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.793062] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.002s)
[121.927921] [016/156] (897s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[122.307348] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[123.147395] [017/156] (896s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[123.252220] Starting subtest: fbc-tiling-linear
[126.986452] Subtest fbc-tiling-linear: SUCCESS (3.738s)
[128.176053] [018/156] (891s left) gem_exec_balancer (bonded-semaphore)
[128.232412] Starting subtest: bonded-semaphore
[128.236695] Subtest bonded-semaphore: SKIP (0.000s)
[128.531418] [019/156] (891s left) gem_exec_params (invalid-fence-in)
[128.581225] Starting subtest: invalid-fence-in
[128.583272] Subtest invalid-fence-in: SUCCESS (0.001s)
[128.687772] [020/156] (891s left) kms_pm_backlight (fade-with-suspend)
[128.787339] Starting subtest: fade-with-suspend
[145.105455] Starting dynamic subtest: eDP-1
[148.106312] Dynamic subtest eDP-1: SUCCESS (2.951s)
[148.108939] Subtest fade-with-suspend: SUCCESS (5.084s)
[148.974103] [021/156] (870s left) kms_chamelium_audio (hdmi-audio)
[149.370007] Subtest hdmi-audio: SKIP (0.000s)
[150.211613] [022/156] (869s left) kms_flip (flip-vs-expired-vblank-interruptible)
[150.308731] Starting subtest: flip-vs-expired-vblank-interruptible
[150.311212] Starting dynamic subtest: A-eDP1
[158.975434] Dynamic subtest A-eDP1: SUCCESS (8.579s)
[158.986915] Starting dynamic subtest: B-eDP1
[167.666873] Dynamic subtest B-eDP1: SUCCESS (8.661s)
[167.676087] Starting dynamic subtest: C-eDP1
[176.329919] Dynamic subtest C-eDP1: SUCCESS (8.650s)
[176.339296] Starting dynamic subtest: D-eDP1
[184.959818] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[184.962580] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.522s)
[186.138574] [023/156] (833s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[186.241247] Starting subtest: addfb25-y-tiled-legacy
[186.243858] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[186.332413] [024/156] (833s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[186.398009] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[186.400500] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[186.491175] [025/156] (833s left) gem_ppgtt (shrink-vs-evict-pinned)
[186.541870] Starting subtest: shrink-vs-evict-pinned
[192.441674] Subtest shrink-vs-evict-pinned: SUCCESS (5.895s)
[192.532716] [026/156] (827s left) sysfs_heartbeat_interval (precise)
[192.590292] Starting subtest: precise
[192.592366] Starting dynamic subtest: vecs0
[200.489985] Dynamic subtest vecs0: SUCCESS (7.891s)
[200.500911] Starting dynamic subtest: ccs0
[201.552368] Dynamic subtest ccs0: SUCCESS (1.065s)
[201.562585] Starting dynamic subtest: vcs0
[209.445786] Dynamic subtest vcs0: SUCCESS (7.888s)
[209.459762] Starting dynamic subtest: bcs0
[210.500000] Dynamic subtest bcs0: SUCCESS (1.055s)
[210.510812] Starting dynamic subtest: rcs0
[211.563892] Dynamic subtest rcs0: SUCCESS (1.063s)
[211.575086] Starting dynamic subtest: vcs1
[219.489039] Dynamic subtest vcs1: SUCCESS (7.922s)
[219.492164] Subtest precise: SUCCESS (26.888s)
[219.567495] [027/156] (800s left) kms_async_flips (test-cursor)
[219.676451] Starting subtest: test-cursor
[220.052287] Starting dynamic subtest: pipe-A-eDP-1
[220.837728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[221.241258] Starting dynamic subtest: pipe-B-eDP-1
[221.995733] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[222.370254] Starting dynamic subtest: pipe-C-eDP-1
[223.137301] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[223.502311] Starting dynamic subtest: pipe-D-eDP-1
[224.261579] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[224.264277] Subtest test-cursor: SUCCESS (4.585s)
[225.424188] [028/156] (794s left) vgem_basic (setversion)
[225.467711] Starting subtest: setversion
[225.472310] Subtest setversion: SUCCESS (0.000s)
[225.527398] [029/156] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[225.623416] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[232.397866] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.777s)
[232.498612] [030/156] (787s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[232.611657] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[232.616498] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[232.759667] [031/156] (787s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[232.849416] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[232.852037] Starting dynamic subtest: pipe-A-eDP-1
[232.880018] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.889946] Starting dynamic subtest: pipe-B-eDP-1
[232.915444] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.924941] Starting dynamic subtest: pipe-C-eDP-1
[232.950619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.959479] Starting dynamic subtest: pipe-D-eDP-1
[232.985541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.990634] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[235.109910] [032/156] (785s left) gem_exec_capture (capture-recoverable)
[235.168212] Starting subtest: capture-recoverable
[235.170854] Subtest capture-recoverable: SUCCESS (0.003s)
[235.286813] [033/156] (784s left) gem_render_copy (linear-to-vebox-yf-tiled)
[235.348042] Starting subtest: linear-to-vebox-yf-tiled
[235.353592] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[235.539413] [034/156] (784s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[235.643196] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[236.300556] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[236.452018] [035/156] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[236.544754] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[243.893004] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.350s)
[244.046670] [036/156] (776s left) kms_cursor_edge_walk (128x128-top-bottom)
[244.145726] Starting subtest: 128x128-top-bottom
[244.148321] Starting dynamic subtest: pipe-A-eDP-1
[247.594632] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[247.605714] Starting dynamic subtest: pipe-D-eDP-1
[250.720858] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[250.723799] Subtest 128x128-top-bottom: SUCCESS (6.579s)
[251.535673] [037/156] (768s left) gem_exec_reloc (basic-cpu-read)
[251.598830] Subtest basic-cpu-read: SKIP (0.000s)
[251.670196] [038/156] (768s left) gem_eio (execbuf)
[251.890585] Starting subtest: execbuf
[252.199601] Subtest execbuf: SUCCESS (0.308s)
[252.317196] [039/156] (768s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[252.421924] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[252.426777] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[252.520266] [040/156] (768s left) gem_userptr_blits (create-destroy-sync)
[252.574938] Starting subtest: create-destroy-sync
[257.582285] Subtest create-destroy-sync: SUCCESS (5.008s)
[257.730914] [041/156] (762s left) template (b)
[257.783831] Starting subtest: B
[257.786411] Subtest B: SUCCESS (0.000s)
[257.876861] [042/156] (762s left) syncobj_timeline (multi-wait-available-submitted)
[257.923856] Starting subtest: multi-wait-available-submitted
[257.926784] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[258.017266] [043/156] (762s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[258.129879] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[258.134774] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[258.234375] [044/156] (762s left) gen3_render_linear_blits
[258.350816] [045/156] (762s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[258.438992] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[258.444804] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[258.513604] [046/156] (762s left) perf_pmu (busy-accuracy-2)
[258.562878] Starting subtest: busy-accuracy-2
[258.565646] Starting dynamic subtest: rcs0
[261.610667] Dynamic subtest rcs0: SUCCESS (3.045s)
[261.621817] Starting dynamic subtest: bcs0
[264.668732] Dynamic subtest bcs0: SUCCESS (3.056s)
[264.679586] Starting dynamic subtest: vcs0
[267.716732] Dynamic subtest vcs0: SUCCESS (3.046s)
[267.727427] Starting dynamic subtest: vcs1
[270.760750] Dynamic subtest vcs1: SUCCESS (3.043s)
[270.772951] Starting dynamic subtest: vecs0
[273.805713] Dynamic subtest vecs0: SUCCESS (3.042s)
[273.818698] Starting dynamic subtest: ccs0
[276.866808] Dynamic subtest ccs0: SUCCESS (3.058s)
[276.869816] Subtest busy-accuracy-2: SUCCESS (18.301s)
[276.982340] [047/156] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[277.093519] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[284.089002] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.001s)
[284.208737] [048/156] (736s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[284.320691] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[285.044418] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.726s)
[285.210452] [049/156] (735s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[285.304431] Starting subtest: nonblocking-crc-frame-sequence
[285.306913] Starting dynamic subtest: pipe-A-eDP-1
[286.070538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.762s)
[286.081316] Starting dynamic subtest: pipe-B-eDP-1
[287.448561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[287.460786] Starting dynamic subtest: pipe-C-eDP-1
[288.847633] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[288.858964] Starting dynamic subtest: pipe-D-eDP-1
[290.265030] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.414s)
[290.267496] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.958s)
[291.076342] [050/156] (729s left) gem_ctx_isolation (dirty-switch)
[291.143472] Starting subtest: dirty-switch
[291.145956] Starting dynamic subtest: rcs0
[291.338289] Dynamic subtest rcs0: SUCCESS (0.195s)
[291.349630] Starting dynamic subtest: bcs0
[291.533691] Dynamic subtest bcs0: SUCCESS (0.194s)
[291.544904] Starting dynamic subtest: vcs0
[291.754465] Dynamic subtest vcs0: SUCCESS (0.220s)
[291.765054] Starting dynamic subtest: vcs1
[293.674321] Dynamic subtest vcs1: SUCCESS (1.918s)
[293.686027] Starting dynamic subtest: vecs0
[295.679359] Dynamic subtest vecs0: SUCCESS (2.004s)
[295.693723] Starting dynamic subtest: ccs0
[297.660309] Dynamic subtest ccs0: SUCCESS (1.980s)
[297.663347] Subtest dirty-switch: SUCCESS (6.516s)
[297.894527] [051/156] (723s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[297.999029] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[298.901050] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.903s)
[299.050621] [052/156] (722s left) vgem_basic (sysfs)
[299.096794] Starting subtest: sysfs
[299.099151] Subtest sysfs: SUCCESS (0.000s)
[299.160854] [053/156] (721s left) gem_ctx_shared (q-promotion)
[299.228225] Starting subtest: Q-promotion
[299.230924] Starting dynamic subtest: rcs0
[299.334390] Dynamic subtest rcs0: SUCCESS (0.106s)
[299.347308] Starting dynamic subtest: vcs0
[299.421747] Dynamic subtest vcs0: SUCCESS (0.086s)
[299.432587] Starting dynamic subtest: vcs1
[299.511220] Dynamic subtest vcs1: SUCCESS (0.088s)
[299.527150] Starting dynamic subtest: vecs0
[299.597396] Dynamic subtest vecs0: SUCCESS (0.085s)
[299.615082] Starting dynamic subtest: ccs0
[299.687013] Dynamic subtest ccs0: SUCCESS (0.089s)
[299.689716] Subtest Q-promotion: SUCCESS (0.460s)
[300.544372] [054/156] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[300.649211] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[307.489860] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.845s)
[307.617567] [055/156] (713s left) gem_lmem_swapping (heavy-random)
[307.664025] Subtest heavy-random: SKIP (0.000s)
[307.711126] [056/156] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[307.807646] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[307.812401] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[307.901834] [057/156] (713s left) gem_exec_params (sol-reset-invalid)
[307.960040] Starting subtest: sol-reset-invalid
[307.962809] Subtest sol-reset-invalid: SUCCESS (0.002s)
[309.558789] [058/156] (711s left) gem_eio (reset-stress)
[309.771769] Starting subtest: reset-stress
[309.774734] Starting dynamic subtest: render
[314.652454] Dynamic subtest render: SUCCESS (4.878s)
[314.669088] Starting dynamic subtest: bsd1
[332.954909] Dynamic subtest bsd1: SUCCESS (18.295s)
[332.972498] Starting dynamic subtest: bsd2
[351.000075] Dynamic subtest bsd2: SUCCESS (18.038s)
[351.016610] Starting dynamic subtest: blt
[351.021679] Dynamic subtest blt: SKIP (0.000s)
[351.032868] Starting dynamic subtest: vebox
[369.024528] Dynamic subtest vebox: SUCCESS (18.018s)
[369.027044] Subtest reset-stress: SUCCESS (59.234s)
[370.504534] [059/156] (650s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[370.602409] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[370.607026] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[370.695933] [060/156] (650s left) gem_partial_pwrite_pread (write-display)
[370.749701] Subtest write-display: SKIP (0.000s)
[370.834808] [061/156] (650s left) gem_exec_create (forked)
[370.891809] Starting subtest: forked
[370.894527] Starting dynamic subtest: smem
[391.108292] Dynamic subtest smem: SUCCESS (20.226s)
[391.111286] Subtest forked: SUCCESS (20.228s)
[391.298376] [062/156] (630s left) gem_mmap_wc (write)
[391.348761] Subtest write: SKIP (0.000s)
[391.407681] [063/156] (630s left) kms_content_protection (dp-mst-type-0-hdcp14)
[391.552462] Starting subtest: dp-mst-type-0-hdcp14
[391.556834] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[391.666345] [064/156] (629s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[391.772046] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[391.776811] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[391.868572] [065/156] (629s left) kms_draw_crc (draw-method-mmap-cpu)
[391.971697] Starting subtest: draw-method-mmap-cpu
[391.973764] Starting dynamic subtest: xrgb8888-untiled
[392.226889] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[392.238531] Starting dynamic subtest: rgb565-untiled
[392.446940] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[392.456814] Starting dynamic subtest: xrgb2101010-untiled
[392.658073] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[392.668026] Starting dynamic subtest: xbgr16161616f-untiled
[392.869315] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[392.879812] Starting dynamic subtest: xrgb8888-xtiled
[392.991413] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[393.002251] Starting dynamic subtest: rgb565-xtiled
[393.113690] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[393.124624] Starting dynamic subtest: xrgb2101010-xtiled
[393.224525] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[393.235831] Starting dynamic subtest: xbgr16161616f-xtiled
[393.357522] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[393.367698] Starting dynamic subtest: xrgb8888-4tiled
[393.491006] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[393.500936] Starting dynamic subtest: rgb565-4tiled
[393.635881] Dynamic subtest rgb565-4tiled: SUCCESS (0.145s)
[393.649026] Starting dynamic subtest: xrgb2101010-4tiled
[393.768720] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[393.779001] Starting dynamic subtest: xbgr16161616f-4tiled
[393.901762] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[393.903669] Subtest draw-method-mmap-cpu: SUCCESS (1.934s)
[393.986587] [066/156] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[394.084336] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[401.527654] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.448s)
[401.651922] [067/156] (620s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[401.751796] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[401.756756] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.858057] [068/156] (619s left) kms_rotation_crc (primary-rotation-180)
[401.955898] Starting subtest: primary-rotation-180
[409.233762] Subtest primary-rotation-180: SUCCESS (7.281s)
[410.435242] [069/156] (611s left) vgem_slow (nohang)
[410.482014] Starting subtest: nohang
[420.668907] Subtest nohang: SUCCESS (10.187s)
[420.736935] [070/156] (601s left) i915_query (query-topology-known-pci-ids)
[420.799061] Starting subtest: query-topology-known-pci-ids
[420.804266] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[420.898993] [071/156] (601s left) i915_hangman (engine-engine-error)
[420.965038] Starting subtest: engine-engine-error
[420.967727] Starting dynamic subtest: rcs0
[422.461516] Dynamic subtest rcs0: SUCCESS (1.494s)
[422.476028] Starting dynamic subtest: bcs0
[424.444406] Dynamic subtest bcs0: SUCCESS (1.981s)
[424.457815] Starting dynamic subtest: vcs0
[426.428493] Dynamic subtest vcs0: SUCCESS (1.981s)
[426.442926] Starting dynamic subtest: vcs1
[428.413453] Dynamic subtest vcs1: SUCCESS (1.982s)
[428.426607] Starting dynamic subtest: vecs0
[430.460197] Dynamic subtest vecs0: SUCCESS (2.044s)
[430.474890] Starting dynamic subtest: ccs0
[432.444815] Dynamic subtest ccs0: SUCCESS (1.982s)
[432.447783] Subtest engine-engine-error: SUCCESS (11.480s)
[432.572490] [072/156] (589s left) gem_ctx_persistence (legacy-engines-persistence)
[432.627842] Starting subtest: legacy-engines-persistence
[432.630582] Starting dynamic subtest: render
[433.436298] Dynamic subtest render: SUCCESS (0.807s)
[433.448868] Starting dynamic subtest: bsd1
[434.205482] Dynamic subtest bsd1: SUCCESS (0.766s)
[434.219234] Starting dynamic subtest: bsd2
[434.967446] Dynamic subtest bsd2: SUCCESS (0.759s)
[434.980638] Starting dynamic subtest: blt
[435.737048] Dynamic subtest blt: SUCCESS (0.767s)
[435.750668] Starting dynamic subtest: vebox
[436.506163] Dynamic subtest vebox: SUCCESS (0.766s)
[436.508992] Subtest legacy-engines-persistence: SUCCESS (3.879s)
[436.591255] [073/156] (585s left) perf_pmu (enable-race)
[436.631903] Starting subtest: enable-race
[436.634860] Starting dynamic subtest: rcs0
[449.399821] Dynamic subtest rcs0: SUCCESS (12.769s)
[449.410852] Starting dynamic subtest: bcs0
[462.144685] Dynamic subtest bcs0: SUCCESS (12.743s)
[462.155785] Starting dynamic subtest: vcs0
[477.471997] Dynamic subtest vcs0: SUCCESS (15.321s)
[477.483735] Starting dynamic subtest: vcs1
[493.470924] Dynamic subtest vcs1: SUCCESS (15.994s)
[493.483728] Starting dynamic subtest: vecs0
[509.471665] Dynamic subtest vecs0: SUCCESS (15.995s)
[509.485061] Starting dynamic subtest: ccs0
[522.218730] Dynamic subtest ccs0: SUCCESS (12.743s)
[522.221535] Subtest enable-race: SUCCESS (85.577s)
[522.322783] [074/156] (499s left) kms_psr (pr-primary-page-flip)
[522.422014] Starting subtest: pr-primary-page-flip
[522.427541] Subtest pr-primary-page-flip: SKIP (0.000s)
[522.509274] [075/156] (499s left) perf (rc6-disable)
[522.641709] Starting subtest: rc6-disable
[522.818798] Subtest rc6-disable: SUCCESS (0.178s)
[522.872684] [076/156] (499s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[522.973631] Starting subtest: fbc-rgb565-draw-blt
[527.106691] Subtest fbc-rgb565-draw-blt: SUCCESS (4.139s)
[528.240495] [077/156] (493s left) syncobj_wait (wait-all-complex)
[528.293003] Starting subtest: wait-all-complex
[528.509004] Subtest wait-all-complex: SUCCESS (0.216s)
[528.587511] [078/156] (493s left) gen7_exec_parse (bitmasks)
[528.647826] Subtest bitmasks: SKIP (0.000s)
[528.717944] [079/156] (493s left) gem_watchdog (default-physical)
[528.781040] Starting subtest: default-physical
[530.535631] Subtest default-physical: SUCCESS (1.769s)
[530.628105] [080/156] (491s left) gem_exec_schedule (u-semaphore-noskip)
[530.700049] Starting subtest: u-semaphore-noskip
[531.155927] Subtest u-semaphore-noskip: SUCCESS (0.462s)
[531.509667] [081/156] (490s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[531.558942] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[531.667109] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[531.749859] [082/156] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[531.856358] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[531.861382] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[531.965111] [083/156] (490s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[532.063099] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[532.068601] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[532.141335] [084/156] (490s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[532.194889] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[532.200622] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[532.381703] [085/156] (490s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[532.482584] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[532.487676] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[532.587746] [086/156] (490s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[532.689332] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[532.693991] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[532.776696] [087/156] (489s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[532.862792] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[532.868147] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[532.937369] [088/156] (489s left) gem_mmap_gtt (hang-user)
[533.000883] Subtest hang-user: SKIP (0.000s)
[533.061064] [089/156] (489s left) kms_psr (pr-cursor-mmap-cpu)
[533.148088] Starting subtest: pr-cursor-mmap-cpu
[533.153479] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[533.222145] [090/156] (489s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[533.324822] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[533.329039] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[533.423080] [091/156] (489s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[533.520852] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[533.523164] Starting dynamic subtest: A-eDP1
[542.479924] Dynamic subtest A-eDP1: SUCCESS (8.956s)
[542.493329] Starting dynamic subtest: B-eDP1
[551.408629] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[551.422329] Starting dynamic subtest: C-eDP1
[560.335286] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[560.348512] Starting dynamic subtest: D-eDP1
[569.255527] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[569.258112] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.728s)
[570.480546] [092/156] (452s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[570.586011] Starting subtest: fbc-rgb101010-draw-render
[573.075442] Subtest fbc-rgb101010-draw-render: SUCCESS (2.495s)
[574.268440] [093/156] (448s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[574.377131] Starting subtest: y-tiled-8bpp-rotate-180
[574.382618] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[574.478175] [094/156] (448s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[574.574790] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[574.579850] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[574.668409] [095/156] (448s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[574.780594] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[574.784950] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[574.879738] [096/156] (448s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[574.973776] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[575.000002] Starting dynamic subtest: pipe-A-plane-0
[575.288460] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[575.298672] Starting dynamic subtest: pipe-A-plane-3
[575.499314] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[575.509733] Starting dynamic subtest: pipe-A-plane-5
[575.514752] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[576.651620] Starting dynamic subtest: pipe-B-plane-0
[576.931947] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[576.951289] Starting dynamic subtest: pipe-B-plane-3
[577.142961] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[577.153783] Starting dynamic subtest: pipe-B-plane-5
[577.158941] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[577.465519] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.492s)
[578.339871] [097/156] (444s left) kms_pm_rpm (legacy-planes-dpms)
[580.575788] Starting subtest: legacy-planes-dpms
[580.578634] Starting dynamic subtest: plane-65
[588.893287] Dynamic subtest plane-65: SUCCESS (8.319s)
[588.908639] Starting dynamic subtest: plane-95
[597.231702] Dynamic subtest plane-95: SUCCESS (8.333s)
[597.244844] Starting dynamic subtest: plane-125
[605.660392] Dynamic subtest plane-125: SUCCESS (8.424s)
[605.673569] Starting dynamic subtest: plane-135
[613.987262] Dynamic subtest plane-135: SUCCESS (8.322s)
[613.989920] Subtest legacy-planes-dpms: SUCCESS (33.409s)
[614.385514] [098/156] (408s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[614.491721] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[614.495910] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[614.595761] [099/156] (408s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[614.689827] Starting subtest: fbc-pr-cursor-mmap-gtt
[614.694921] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[614.764922] [100/156] (408s left) gem_close_race (basic-threads)
[614.837520] Starting subtest: basic-threads
[616.187789] Subtest basic-threads: SUCCESS (1.348s)
[616.375313] [101/156] (406s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[616.472642] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[616.477627] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.564175] [102/156] (406s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[616.722906] Starting subtest: cursor-rapid-movement-32x10
[616.764305] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[617.079599] [103/156] (406s left) gem_exec_schedule (pi-userfault)
[617.257552] Starting subtest: pi-userfault
[617.259828] Starting dynamic subtest: rcs0
[617.269167] Dynamic subtest rcs0: SUCCESS (0.014s)
[617.280658] Starting dynamic subtest: bcs0
[617.283429] Dynamic subtest bcs0: SUCCESS (0.011s)
[617.293924] Starting dynamic subtest: vcs0
[617.296661] Dynamic subtest vcs0: SUCCESS (0.010s)
[617.307307] Starting dynamic subtest: vcs1
[617.309406] Dynamic subtest vcs1: SUCCESS (0.010s)
[617.320913] Starting dynamic subtest: vecs0
[617.323386] Dynamic subtest vecs0: SUCCESS (0.008s)
[617.333557] Starting dynamic subtest: ccs0
[617.335889] Dynamic subtest ccs0: SUCCESS (0.010s)
[617.338512] Subtest pi-userfault: SUCCESS (0.068s)
[617.512561] [104/156] (405s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[617.592575] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[617.596612] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[617.668267] [105/156] (405s left) kms_chamelium_frames (vga-frame-dump)
[618.053684] Subtest vga-frame-dump: SKIP (0.000s)
[618.877600] [106/156] (404s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[618.971955] Starting subtest: hdr-rgb101010-draw-blt
[618.976611] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[619.066715] [107/156] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[619.165224] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[619.170238] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[619.247372] [108/156] (404s left) gem_exec_fence (basic-busy-all)
[619.303566] Starting subtest: basic-busy-all
[619.388772] Subtest basic-busy-all: SUCCESS (0.086s)
[621.529364] [109/156] (402s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[621.626176] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[626.028010] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.409s)
[627.210714] [110/156] (396s left) gem_exec_whisper (basic-normal-all)
[627.274520] Starting subtest: basic-normal-all
[629.649022] Subtest basic-normal-all: SUCCESS (2.374s)
[629.833848] [111/156] (393s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[629.933787] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[629.938337] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[630.031117] [112/156] (393s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[630.118754] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[630.123890] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[630.191198] [113/156] (393s left) gem_softpin (evict-prime-sanity-check)
[630.250534] Starting subtest: evict-prime-sanity-check
[630.253173] Starting dynamic subtest: rcs0
[631.391053] Dynamic subtest rcs0: SUCCESS (1.141s)
[631.402592] Starting dynamic subtest: bcs0
[632.505642] Dynamic subtest bcs0: SUCCESS (1.114s)
[632.520482] Starting dynamic subtest: vcs0
[634.460433] Dynamic subtest vcs0: SUCCESS (1.954s)
[634.477166] Starting dynamic subtest: vcs1
[636.442415] Dynamic subtest vcs1: SUCCESS (1.981s)
[636.454299] Starting dynamic subtest: vecs0
[638.482331] Dynamic subtest vecs0: SUCCESS (2.039s)
[638.494955] Starting dynamic subtest: ccs0
[639.596440] Dynamic subtest ccs0: SUCCESS (1.113s)
[639.608680] Starting dynamic subtest: all
[640.705957] Dynamic subtest all: SUCCESS (1.110s)
[640.709169] Subtest evict-prime-sanity-check: SUCCESS (10.462s)
[640.786726] [114/156] (383s left) kms_psr (psr-sprite-blt)
[640.894700] Starting subtest: psr-sprite-blt
[640.897481] Starting dynamic subtest: eDP-1
[642.693544] Dynamic subtest eDP-1: SUCCESS (1.802s)
[642.696305] Subtest psr-sprite-blt: SUCCESS (1.803s)
[643.557947] [115/156] (380s left) kms_flip (2x-flip-vs-panning)
[643.652822] Starting subtest: 2x-flip-vs-panning
[643.660941] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[643.753269] [116/156] (380s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[643.851497] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[643.856490] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[643.943909] [117/156] (379s left) kms_psr (psr-primary-mmap-gtt)
[644.033573] Starting subtest: psr-primary-mmap-gtt
[644.035849] Starting dynamic subtest: eDP-1
[645.460016] Dynamic subtest eDP-1: SKIP (1.425s)
[645.465191] Subtest psr-primary-mmap-gtt: SKIP (1.427s)
[645.584901] [118/156] (378s left) gem_exec_params (cliprects_ptr-dirt)
[645.643817] Starting subtest: cliprects_ptr-dirt
[645.646425] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[645.744558] [119/156] (378s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[645.845235] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[645.850451] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[645.942959] [120/156] (378s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[646.034779] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[646.039856] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[646.136473] [121/156] (377s left) gem_partial_pwrite_pread (reads-uncached)
[646.196999] Subtest reads-uncached: SKIP (0.000s)
[646.265317] [122/156] (377s left) i915_pm_rpm (system-suspend-execbuf)
[647.791609] Starting subtest: system-suspend-execbuf
[707.811415] Subtest system-suspend-execbuf: SUCCESS (44.564s)
[708.206212] [123/156] (315s left) kms_cursor_crc (cursor-offscreen-64x21)
[708.404621] Starting subtest: cursor-offscreen-64x21
[708.455379] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[708.701978] [124/156] (315s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[708.801934] Starting subtest: fbcpsr-rgb101010-draw-blt
[713.531763] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.733s)
[713.645084] [125/156] (310s left) kms_pm_rpm (modeset-stress-extra-wait)
[715.776204] Starting subtest: modeset-stress-extra-wait
[770.162431] Subtest modeset-stress-extra-wait: SUCCESS (54.370s)
[770.258351] [126/156] (254s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[770.353841] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[770.358655] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[770.454955] [127/156] (253s left) kms_color (ctm-red-to-blue)
[770.548821] Starting subtest: ctm-red-to-blue
[770.551227] Starting dynamic subtest: pipe-A-eDP-1
[771.277159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[771.288827] Starting dynamic subtest: pipe-B-eDP-1
[772.746986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[772.757904] Starting dynamic subtest: pipe-C-eDP-1
[774.103959] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[774.115195] Starting dynamic subtest: pipe-D-eDP-1
[775.434684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[775.437494] Subtest ctm-red-to-blue: SUCCESS (4.890s)
[776.250917] [128/156] (248s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[776.343391] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[776.347919] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[776.411311] [129/156] (248s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[776.511198] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[776.516322] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[776.597482] [130/156] (247s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[776.695226] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[776.699795] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[776.790474] [131/156] (247s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[776.891700] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[776.897154] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[777.014031] [132/156] (247s left) syncobj_basic (bad-create-flags)
[777.068914] Starting subtest: bad-create-flags
[777.071497] Subtest bad-create-flags: SUCCESS (0.000s)
[777.184788] [133/156] (247s left) gem_exec_parallel (fds)
[777.237302] Starting subtest: fds
[777.239754] Starting dynamic subtest: rcs0
[781.056677] Dynamic subtest rcs0: SUCCESS (3.818s)
[781.068181] Starting dynamic subtest: bcs0
[785.880757] Dynamic subtest bcs0: SUCCESS (4.822s)
[785.893580] Starting dynamic subtest: vcs0
[789.954176] Dynamic subtest vcs0: SUCCESS (4.071s)
[789.968671] Starting dynamic subtest: vcs1
[795.745246] Dynamic subtest vcs1: SUCCESS (5.788s)
[795.759560] Starting dynamic subtest: vecs0
[799.895351] Dynamic subtest vecs0: SUCCESS (4.149s)
[799.906403] Starting dynamic subtest: ccs0
[804.655586] Dynamic subtest ccs0: SUCCESS (4.758s)
[804.658663] Subtest fds: SUCCESS (27.418s)
[804.861851] [134/156] (219s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[804.978403] Starting subtest: x-tiled-8bpp-rotate-90
[804.999930] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[805.102666] [135/156] (219s left) kms_plane (plane-panning-bottom-right-suspend)
[805.203608] Starting subtest: plane-panning-bottom-right-suspend
[805.205831] Starting dynamic subtest: pipe-A
[823.481934] Dynamic subtest pipe-A: SUCCESS (2.878s)
[823.494157] Starting dynamic subtest: pipe-B
[842.458144] Dynamic subtest pipe-B: SUCCESS (3.465s)
[842.460614] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.345s)
[843.264521] [136/156] (181s left) kms_psr (fbc-psr2-cursor-blt)
[843.359912] Starting subtest: fbc-psr2-cursor-blt
[843.362083] Starting dynamic subtest: eDP-1
[843.366036] Dynamic subtest eDP-1: SKIP (0.000s)
[843.369968] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[843.435531] [137/156] (181s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[843.492065] Starting subtest: etime-multi-wait-all-submitted-signaled
[843.600744] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[843.680815] [138/156] (181s left) syncobj_timeline (reset-unsignaled)
[843.730306] Starting subtest: reset-unsignaled
[843.732447] Subtest reset-unsignaled: SUCCESS (0.000s)
[843.831729] [139/156] (181s left) syncobj_timeline (single-wait-available-signaled)
[843.880262] Starting subtest: single-wait-available-signaled
[843.882230] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[843.998249] [140/156] (180s left) perf (enable-disable)
[844.100769] Starting subtest: enable-disable
[844.103306] Starting dynamic subtest: 0-rcs0
[846.371277] Dynamic subtest 0-rcs0: SUCCESS (2.269s)
[846.383145] Starting dynamic subtest: 1-vecs0
[850.835750] Dynamic subtest 1-vecs0: SUCCESS (4.465s)
[850.838393] Subtest enable-disable: SUCCESS (6.736s)
[850.890424] [141/156] (174s left) prime_busy (before)
[850.955214] Starting subtest: before
[850.957619] Starting dynamic subtest: rcs0
[850.994113] Dynamic subtest rcs0: SUCCESS (0.037s)
[851.006744] Starting dynamic subtest: bcs0
[851.046326] Dynamic subtest bcs0: SUCCESS (0.052s)
[851.058838] Starting dynamic subtest: vcs0
[851.090059] Dynamic subtest vcs0: SUCCESS (0.043s)
[851.101041] Starting dynamic subtest: vcs1
[851.133932] Dynamic subtest vcs1: SUCCESS (0.043s)
[851.144824] Starting dynamic subtest: vecs0
[851.177369] Dynamic subtest vecs0: SUCCESS (0.043s)
[851.191740] Starting dynamic subtest: ccs0
[851.222655] Dynamic subtest ccs0: SUCCESS (0.045s)
[851.329523] Subtest before: SUCCESS (0.374s)
[851.405322] [142/156] (173s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[851.507270] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[851.511499] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[851.607602] [143/156] (173s left) i915_suspend (sysfs-reader)
[851.661397] Starting subtest: sysfs-reader
[870.065495] Subtest sysfs-reader: SUCCESS (3.128s)
[870.111956] [144/156] (155s left) kms_mmap_write_crc (main)
[870.220400] Starting subtest: main
[870.222445] Starting dynamic subtest: pipe-A-eDP-1
[873.614492] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.394s)
[873.616902] Subtest main: SUCCESS (3.395s)
[874.479503] [145/156] (150s left) kms_sequence (get-forked)
[874.571726] Starting subtest: get-forked
[874.574488] Starting dynamic subtest: pipe-A-eDP-1
[876.438944] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.868s)
[876.450217] Starting dynamic subtest: pipe-B-eDP-1
[879.023183] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.580s)
[879.035552] Starting dynamic subtest: pipe-C-eDP-1
[881.552301] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.527s)
[881.564129] Starting dynamic subtest: pipe-D-eDP-1
[884.047389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[884.049956] Subtest get-forked: SUCCESS (9.477s)
[884.902401] [146/156] (140s left) dumb_buffer (map-invalid-size)
[884.972584] Starting subtest: map-invalid-size
[884.975191] Subtest map-invalid-size: SUCCESS (0.000s)
[885.084415] [147/156] (140s left) gem_exec_parallel (contexts)
[885.140093] Starting subtest: contexts
[885.142510] Starting dynamic subtest: rcs0
[888.891901] Dynamic subtest rcs0: SUCCESS (3.750s)
[888.906609] Starting dynamic subtest: bcs0
[893.488142] Dynamic subtest bcs0: SUCCESS (4.595s)
[893.500188] Starting dynamic subtest: vcs0
[899.216367] Dynamic subtest vcs0: SUCCESS (5.725s)
[899.228474] Starting dynamic subtest: vcs1
[905.183011] Dynamic subtest vcs1: SUCCESS (5.963s)
[905.194660] Starting dynamic subtest: vecs0
[911.146076] Dynamic subtest vecs0: SUCCESS (5.960s)
[911.157371] Starting dynamic subtest: ccs0
[915.672900] Dynamic subtest ccs0: SUCCESS (4.524s)
[915.675928] Subtest contexts: SUCCESS (30.531s)
[915.862459] [148/156] (109s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[915.972404] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[915.977583] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[916.067435] [149/156] (109s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[916.182888] Starting subtest: flip-vs-cursor-busy-crc-atomic
[916.929599] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.744s)
[917.854260] [150/156] (107s left) gem_exec_fence (long-history)
[918.332090] Starting subtest: long-history
[925.569155] Subtest long-history: SUCCESS (7.238s)
[926.194887] [151/156] ( 99s left) kms_joiner (basic-ultra-joiner)
[926.296616] Starting subtest: basic-ultra-joiner
[926.301667] Subtest basic-ultra-joiner: SKIP (0.000s)
[926.376943] [152/156] ( 99s left) api_intel_allocator (fork-simple-stress-signal)
[926.433224] Starting subtest: fork-simple-stress-signal
[931.834763] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[931.974320] [153/156] ( 93s left) prime_udl
[932.069294] [154/156] ( 93s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[932.167636] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[932.170298] Starting dynamic subtest: pipe-A-eDP-1
[932.191196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[932.207494] Starting dynamic subtest: pipe-B-eDP-1
[932.228321] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[932.239557] Starting dynamic subtest: pipe-C-eDP-1
[932.260032] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[932.271219] Starting dynamic subtest: pipe-D-eDP-1
[932.291816] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[932.294176] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[934.486030] [155/156] ( 91s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[934.589605] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[934.592260] Starting dynamic subtest: pipe-A-eDP-1
[934.616599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[934.631385] Starting dynamic subtest: pipe-B-eDP-1
[934.657334] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[934.668377] Starting dynamic subtest: pipe-C-eDP-1
[934.694004] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[934.704974] Starting dynamic subtest: pipe-D-eDP-1
[934.730514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[934.735977] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[936.845352] [156/156] ( 88s left) gem_create (create-ext-placement-all)
[937.023489] Starting subtest: create-ext-placement-all
[937.026370] Subtest create-ext-placement-all: SUCCESS (0.000s)
[937.142914] Closing watchdogs
results: parsing output: 0/ for test: kms_dirtyfb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_ccs
results: parsing output: 6/ for test: gem_media_fill
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: core_auth
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_reg_read
results: parsing output: 12/ for test: prime_self_import
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_chamelium_audio
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_ppgtt
results: parsing output: 25/ for test: sysfs_heartbeat_interval
results: parsing output: 26/ for test: kms_async_flips
results: parsing output: 27/ for test: vgem_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_capture
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_edge_walk
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: template
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gen3_render_linear_blits
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_ctx_isolation
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: vgem_basic
results: parsing output: 52/ for test: gem_ctx_shared
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: vgem_slow
results: parsing output: 69/ for test: i915_query
results: parsing output: 70/ for test: i915_hangman
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: gem_watchdog
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_close_race
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_partial_pwrite_pread
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_basic
results: parsing output: 132/ for test: gem_exec_parallel
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_plane
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: perf
results: parsing output: 140/ for test: prime_busy
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: i915_suspend
results: parsing output: 143/ for test: kms_mmap_write_crc
results: parsing output: 144/ for test: kms_sequence
results: parsing output: 145/ for test: dumb_buffer
results: parsing output: 146/ for test: gem_exec_parallel
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: gem_exec_fence
results: parsing output: 150/ for test: kms_joiner
results: parsing output: 151/ for test: api_intel_allocator
results: parsing output: 152/ for test: prime_udl
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: kms_ccs
results: parsing output: 155/ for test: gem_create
Done.