[58.078366] Initializing watchdogs
[58.078416]   /dev/watchdog0
[58.094281] [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.099433] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.102843] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.106212] [001/156] (960s left) drm_read (short-buffer-block)
[58.322087] Starting subtest: short-buffer-block
[58.324524] Subtest short-buffer-block: SUCCESS (0.000s)
[58.431428] [002/156] (960s left) perf_pmu (most-busy-idle-check-all)
[58.475669] Starting subtest: most-busy-idle-check-all
[58.478075] Starting dynamic subtest: rcs0
[60.293723] Dynamic subtest rcs0: SUCCESS (1.781s)
[60.302852] Starting dynamic subtest: bcs0
[62.280768] Dynamic subtest bcs0: SUCCESS (1.956s)
[62.290400] Starting dynamic subtest: vcs0
[64.326822] Dynamic subtest vcs0: SUCCESS (2.022s)
[64.335905] Starting dynamic subtest: vcs1
[66.310802] Dynamic subtest vcs1: SUCCESS (1.965s)
[66.320104] Starting dynamic subtest: vecs0
[68.295539] Dynamic subtest vecs0: SUCCESS (1.969s)
[68.306641] Starting dynamic subtest: ccs0
[70.278247] Dynamic subtest ccs0: SUCCESS (1.971s)
[70.281038] Subtest most-busy-idle-check-all: SUCCESS (11.674s)
[70.381170] [003/156] (948s left) kms_chamelium_hpd (vga-hpd-fast)
[70.769802] Subtest vga-hpd-fast: SKIP (0.000s)
[71.563164] [004/156] (947s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[71.660802] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[71.665250] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[71.743444] [005/156] (947s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[71.836246] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[71.840576] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[71.923602] [006/156] (946s left) gem_ctx_persistence (file)
[71.978260] Starting subtest: file
[72.086607] Subtest file: SUCCESS (0.108s)
[72.194562] [007/156] (946s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[72.301299] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[72.305429] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[72.457727] [008/156] (946s left) kms_vblank (query-forked-busy)
[72.756490] Starting subtest: query-forked-busy
[72.759064] Starting dynamic subtest: pipe-A-eDP-1
[74.713385] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[74.726391] Starting dynamic subtest: pipe-D-eDP-1
[77.263102] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[77.265475] Subtest query-forked-busy: SUCCESS (4.495s)
[78.078399] [009/156] (940s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-blt)
[78.173661] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-blt
[78.177788] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[78.269121] [010/156] (940s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[78.367391] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[78.371735] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[78.434349] [011/156] (940s left) gem_softpin (allocator-basic-reserve)
[78.486616] Starting subtest: allocator-basic-reserve
[78.566850] Subtest allocator-basic-reserve: SUCCESS (0.079s)
[78.714256] [012/156] (940s left) gem_lmem_swapping (parallel-multi)
[78.765812] Subtest parallel-multi: SKIP (0.000s)
[78.808271] [013/156] (940s left) gem_exec_balancer (hog)
[78.866729] Starting subtest: hog
[78.871196] Subtest hog: SKIP (0.000s)
[79.170697] [014/156] (939s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[79.275393] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[80.333216] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.058s)
[80.475076] [015/156] (938s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[80.576428] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[80.578374] Starting dynamic subtest: pipe-A
[80.640421] Dynamic subtest pipe-A: SUCCESS (0.065s)
[80.648877] Starting dynamic subtest: pipe-B
[81.796877] Dynamic subtest pipe-B: SUCCESS (1.155s)
[81.808168] Starting dynamic subtest: pipe-C
[82.919617] Dynamic subtest pipe-C: SUCCESS (1.121s)
[82.928943] Starting dynamic subtest: pipe-D
[84.044146] Dynamic subtest pipe-D: SUCCESS (1.123s)
[84.046318] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.466s)
[85.203559] [016/156] (934s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[85.305179] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[85.307637] Starting dynamic subtest: pipe-A-eDP-1
[85.316941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.326594] Starting dynamic subtest: pipe-B-eDP-1
[85.335630] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.344392] Starting dynamic subtest: pipe-C-eDP-1
[85.353170] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.361263] Starting dynamic subtest: pipe-D-eDP-1
[85.369975] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.374464] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[87.568513] [017/156] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[87.676969] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[87.680946] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[87.772808] [018/156] (931s left) gem_mmap_gtt (big-bo-tiledx)
[87.841409] Subtest big-bo-tiledX: SKIP (0.000s)
[87.899968] [019/156] (931s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[87.965481] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[88.018267] [020/156] (931s left) gen9_exec_parse (allowed-single)
[88.079249] Subtest allowed-single: SKIP (0.000s)
[88.138563] [021/156] (931s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[88.228953] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[88.233523] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.345387] [022/156] (931s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[88.449812] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[88.454193] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[88.525620] [023/156] (930s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[88.577273] Starting subtest: wait-all-for-submit-delayed-submit
[88.681513] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[88.784712] [024/156] (930s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[88.886069] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[88.890229] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[88.999009] [025/156] (930s left) syncobj_timeline (single-wait-available-submitted)
[89.054512] Starting subtest: single-wait-available-submitted
[89.056699] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[89.153960] [026/156] (930s left) vgem_basic (mmap)
[89.227693] Starting subtest: mmap
[89.232566] Subtest mmap: SUCCESS (0.007s)
[89.282320] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[89.285905] [027/156] (930s left) kms_psr (psr-cursor-plane-onoff)
[89.377913] Starting subtest: psr-cursor-plane-onoff
[89.380344] Starting dynamic subtest: eDP-1
[91.073524] Dynamic subtest eDP-1: SUCCESS (1.695s)
[91.075872] Subtest psr-cursor-plane-onoff: SUCCESS (1.695s)
[91.940740] [028/156] (927s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[92.047765] Starting subtest: x-tiled-64bpp-rotate-90
[92.068071] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[92.181694] [029/156] (927s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[92.283879] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[92.288315] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[92.387729] [030/156] (927s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[92.484728] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[92.486995] Starting dynamic subtest: pipe-A-eDP-1
[93.782095] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.296s)
[94.070289] Starting dynamic subtest: pipe-B-eDP-1
[95.115996] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[95.390297] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.904s)
[96.232884] [031/156] (923s left) kms_psr (fbc-psr2-cursor-blt)
[96.333767] Starting subtest: fbc-psr2-cursor-blt
[96.335669] Starting dynamic subtest: eDP-1
[96.339773] Dynamic subtest eDP-1: SKIP (0.000s)
[96.343827] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[96.405099] [032/156] (923s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[96.793150] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[97.644241] [033/156] (922s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[97.740749] Starting subtest: 4-tiled-32bpp-rotate-0
[99.189178] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.447s)
[99.321362] [034/156] (920s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[99.414097] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[99.417465] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[99.511205] [035/156] (920s left) device_reset (unbind-reset-rebind)
[99.557107] Starting subtest: unbind-reset-rebind
[104.539979] Subtest unbind-reset-rebind: SUCCESS (4.976s)
[104.584135] [036/156] (915s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[104.698437] Starting subtest: y-tiled-8bpp-rotate-270
[104.702835] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[104.818542] [037/156] (915s left) kms_flip (2x-blocking-wf_vblank)
[104.907539] Starting subtest: 2x-blocking-wf_vblank
[104.917206] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[104.995965] [038/156] (915s left) gem_pread (snoop)
[105.048292] Subtest snoop: SKIP (0.000s)
[105.110949] [039/156] (915s left) kms_plane_lowres (tiling-none)
[105.207629] Starting subtest: tiling-none
[105.209898] Starting dynamic subtest: pipe-A-eDP-1
[105.215665] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[105.505949] Starting dynamic subtest: pipe-B-eDP-1
[105.510717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[105.520104] Starting dynamic subtest: pipe-C-eDP-1
[105.524580] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[105.532969] Starting dynamic subtest: pipe-D-eDP-1
[105.537443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[105.541629] Subtest tiling-none: SKIP (0.293s)
[106.300778] [040/156] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[106.397251] Starting subtest: psr-2p-primscrn-cur-indfb-move
[106.401571] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[106.519310] [041/156] (913s left) kms_content_protection (srm)
[106.663229] Starting subtest: srm
[106.670494] Subtest srm: SKIP (0.003s)
[106.781292] [042/156] (913s left) gem_mmap_gtt (basic-write-gtt)
[106.838960] Subtest basic-write-gtt: SKIP (0.000s)
[106.898384] [043/156] (913s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[106.997988] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[107.002544] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[107.078548] [044/156] (913s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[107.173836] Starting subtest: bad-pixel-format-yf-tiled-ccs
[107.176181] Starting dynamic subtest: pipe-A-eDP-1
[107.199068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.210341] Starting dynamic subtest: pipe-B-eDP-1
[107.230077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.238940] Starting dynamic subtest: pipe-C-eDP-1
[107.256290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.264131] Starting dynamic subtest: pipe-D-eDP-1
[107.282310] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.285958] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[109.467775] [045/156] (910s left) gem_exec_flush (basic-uc-prw-default)
[109.522723] Starting subtest: basic-uc-prw-default
[114.982694] Subtest basic-uc-prw-default: SUCCESS (5.459s)
[115.166710] [046/156] (905s left) syncobj_wait (wait-all-complex)
[115.219729] Starting subtest: wait-all-complex
[115.435354] Subtest wait-all-complex: SUCCESS (0.215s)
[115.511869] [047/156] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt)
[115.625445] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt
[115.630047] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[115.728445] [048/156] (904s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[115.828520] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[115.832818] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.917571] [049/156] (904s left) sriov_basic (enable-vfs-autoprobe-on)
[115.966952] Starting subtest: enable-vfs-autoprobe-on
[115.969281] Starting dynamic subtest: numvfs-1
[116.040660] Dynamic subtest numvfs-1: FAIL (0.011s)
[116.052944] Starting dynamic subtest: numvfs-2
[116.126629] Dynamic subtest numvfs-2: FAIL (0.004s)
[116.137138] Starting dynamic subtest: numvfs-3
[116.210294] Dynamic subtest numvfs-3: FAIL (0.004s)
[116.220091] Starting dynamic subtest: numvfs-4
[116.293385] Dynamic subtest numvfs-4: FAIL (0.004s)
[116.302822] Starting dynamic subtest: numvfs-5
[116.375645] Dynamic subtest numvfs-5: FAIL (0.004s)
[116.385427] Starting dynamic subtest: numvfs-6
[116.457828] Dynamic subtest numvfs-6: FAIL (0.004s)
[116.468440] Starting dynamic subtest: numvfs-7
[116.532345] Dynamic subtest numvfs-7: FAIL (0.004s)
[116.542915] Starting dynamic subtest: numvfs-random
[116.604070] Dynamic subtest numvfs-random: FAIL (0.004s)
[116.615464] Starting dynamic subtest: numvfs-all
[116.675872] Dynamic subtest numvfs-all: FAIL (0.506s)
[116.677647] Subtest enable-vfs-autoprobe-on: FAIL (0.548s)
[116.712935] [050/156] (903s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[116.811462] Starting subtest: yf-tiled-64bpp-rotate-0
[116.815071] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[116.912832] [051/156] (903s left) gem_exec_gttfill (engines)
[116.973220] Starting subtest: engines
[116.975400] Starting dynamic subtest: rcs0
[139.880312] Dynamic subtest rcs0: SUCCESS (22.901s)
[139.891550] Starting dynamic subtest: bcs0
[163.178724] Dynamic subtest bcs0: SUCCESS (23.296s)
[163.189573] Starting dynamic subtest: vcs0
[186.470101] Dynamic subtest vcs0: SUCCESS (23.291s)
[186.481934] Starting dynamic subtest: vcs1
[209.703272] Dynamic subtest vcs1: SUCCESS (23.231s)
[209.712690] Starting dynamic subtest: vecs0
[232.979794] Dynamic subtest vecs0: SUCCESS (23.274s)
[232.991172] Starting dynamic subtest: ccs0
[256.239748] Dynamic subtest ccs0: SUCCESS (23.256s)
[256.242610] Subtest engines: SUCCESS (139.255s)
[256.427142] [052/156] (764s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[256.539839] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[256.649056] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[256.727336] [053/156] (763s left) gem_exec_fence (submit3)
[256.919187] Starting subtest: submit3
[256.923155] Subtest submit3: SKIP (0.000s)
[258.386395] [054/156] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[258.496912] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[258.501134] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[258.594528] [055/156] (762s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[258.696641] Starting subtest: fbc-rgb565-draw-blt
[262.893075] Subtest fbc-rgb565-draw-blt: SUCCESS (4.202s)
[264.080434] [056/156] (756s left) kms_psr (psr2-cursor-mmap-cpu)
[264.185270] Starting subtest: psr2-cursor-mmap-cpu
[264.187650] Starting dynamic subtest: eDP-1
[265.937629] Dynamic subtest eDP-1: SUCCESS (1.752s)
[265.939774] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.753s)
[266.827575] [057/156] (754s left) gem_ctx_param (set-priority-not-supported)
[266.885607] Starting subtest: set-priority-not-supported
[266.890218] Subtest set-priority-not-supported: SKIP (0.000s)
[266.957862] [058/156] (753s left) gem_mmap_gtt (hang-busy)
[267.017102] Subtest hang-busy: SKIP (0.000s)
[267.071135] [059/156] (753s left) kms_flip (modeset-vs-vblank-race-interruptible)
[267.172248] Starting subtest: modeset-vs-vblank-race-interruptible
[267.174622] Starting dynamic subtest: A-eDP1
[271.973356] Dynamic subtest A-eDP1: SUCCESS (4.799s)
[271.987208] Starting dynamic subtest: B-eDP1
[276.788723] Dynamic subtest B-eDP1: SUCCESS (4.813s)
[276.804996] Starting dynamic subtest: C-eDP1
[281.474850] Dynamic subtest C-eDP1: SUCCESS (4.683s)
[281.487071] Starting dynamic subtest: D-eDP1
[286.092554] Dynamic subtest D-eDP1: SUCCESS (4.616s)
[286.094817] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.923s)
[287.272285] [060/156] (733s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[287.376134] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[287.380096] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[287.485544] [061/156] (733s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[287.535893] Starting subtest: multi-wait-for-submit-submitted-signaled
[287.538166] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[287.629663] [062/156] (733s left) gem_vm_create (invalid-create)
[287.689087] Starting subtest: invalid-create
[287.691498] Subtest invalid-create: SUCCESS (0.002s)
[287.781540] [063/156] (733s left) gem_pxp (create-protected-buffer)
[287.925266] Starting subtest: create-protected-buffer
[287.927581] Subtest create-protected-buffer: SUCCESS (0.000s)
[288.040763] [064/156] (733s left) kms_prop_blob (invalid-set-prop-any)
[288.092403] Starting subtest: invalid-set-prop-any
[288.094311] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[288.193873] [065/156] (733s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[288.291898] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[288.295223] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[288.407294] [066/156] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[288.507284] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[288.510601] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[288.613556] [067/156] (732s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[288.732075] Starting subtest: flip-vs-cursor-atomic
[296.247879] Subtest flip-vs-cursor-atomic: SUCCESS (7.514s)
[297.087610] [068/156] (724s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[297.146389] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[297.232977] [069/156] (724s left) kms_draw_crc (draw-method-mmap-cpu)
[297.333074] Starting subtest: draw-method-mmap-cpu
[297.334932] Starting dynamic subtest: xrgb8888-untiled
[297.598857] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[297.610276] Starting dynamic subtest: rgb565-untiled
[297.820597] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[297.830423] Starting dynamic subtest: xrgb2101010-untiled
[298.042483] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[298.052063] Starting dynamic subtest: xbgr16161616f-untiled
[298.276770] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[298.290345] Starting dynamic subtest: xrgb8888-xtiled
[298.420360] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[298.429614] Starting dynamic subtest: rgb565-xtiled
[298.553705] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[298.564535] Starting dynamic subtest: xrgb2101010-xtiled
[298.686951] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[298.696464] Starting dynamic subtest: xbgr16161616f-xtiled
[298.820197] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[298.829506] Starting dynamic subtest: xrgb8888-4tiled
[298.964832] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[298.974518] Starting dynamic subtest: rgb565-4tiled
[299.109122] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[299.118308] Starting dynamic subtest: xrgb2101010-4tiled
[299.255136] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[299.264668] Starting dynamic subtest: xbgr16161616f-4tiled
[299.398367] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[299.400243] Subtest draw-method-mmap-cpu: SUCCESS (2.068s)
[299.531617] [070/156] (721s left) kms_psr (fbc-psr-sprite-render)
[299.621402] Starting subtest: fbc-psr-sprite-render
[299.623403] Starting dynamic subtest: eDP-1
[299.626918] Dynamic subtest eDP-1: SKIP (0.000s)
[299.630531] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[299.714167] [071/156] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[299.811816] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[299.815240] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[299.882267] [072/156] (721s left) i915_query (engine-info-invalid)
[299.938894] Starting subtest: engine-info-invalid
[299.940621] Subtest engine-info-invalid: SUCCESS (0.000s)
[300.041047] [073/156] (721s left) kms_psr (psr-sprite-render)
[300.131074] Starting subtest: psr-sprite-render
[300.132925] Starting dynamic subtest: eDP-1
[301.890784] Dynamic subtest eDP-1: SUCCESS (1.758s)
[301.893058] Subtest psr-sprite-render: SUCCESS (1.758s)
[302.767748] [074/156] (718s left) kms_vblank (wait-idle)
[302.859528] Starting subtest: wait-idle
[302.861619] Starting dynamic subtest: pipe-A-eDP-1
[304.619431] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.760s)
[304.634626] Starting dynamic subtest: pipe-D-eDP-1
[307.098615] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s)
[307.101056] Subtest wait-idle: SUCCESS (4.242s)
[307.918212] [075/156] (713s left) kms_rmfb (rmfb-ioctl)
[308.019490] Starting subtest: rmfb-ioctl
[308.021520] Starting dynamic subtest: pipe-A-eDP-1
[308.121546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[308.132868] Starting dynamic subtest: pipe-B-eDP-1
[309.273406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[309.285532] Starting dynamic subtest: pipe-C-eDP-1
[310.491713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[310.502487] Starting dynamic subtest: pipe-D-eDP-1
[311.634693] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[311.636911] Subtest rmfb-ioctl: SUCCESS (3.619s)
[312.846692] [076/156] (708s left) gem_pxp (reject-modify-context-protection-off-2)
[312.914122] Starting subtest: reject-modify-context-protection-off-2
[312.916031] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[313.029660] [077/156] (708s left) gem_exec_await (wide-contexts)
[313.213043] Starting subtest: wide-contexts
[336.015264] Subtest wide-contexts: SUCCESS (22.800s)
[336.217481] [078/156] (685s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[336.381081] Starting subtest: basic-flip-after-cursor-atomic
[337.373271] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.991s)
[338.180608] [079/156] (683s left) kms_atomic (crtc-invalid-params-fence)
[338.277265] Starting subtest: crtc-invalid-params-fence
[338.279629] Starting dynamic subtest: pipe-A-eDP-1
[338.707317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[338.709507] Subtest crtc-invalid-params-fence: SUCCESS (0.430s)
[339.519744] [080/156] (682s left) gem_exec_whisper (basic-fds-forked-all)
[339.586419] Starting subtest: basic-fds-forked-all
[360.170469] Subtest basic-fds-forked-all: SUCCESS (20.579s)
[360.369365] [081/156] (661s left) gem_exec_create (forked)
[360.442563] Starting subtest: forked
[360.445099] Starting dynamic subtest: smem
[381.318719] Dynamic subtest smem: SUCCESS (20.873s)
[381.321838] Subtest forked: SUCCESS (20.875s)
[381.503516] [082/156] (640s left) vgem_basic (debugfs)
[381.555731] Starting subtest: debugfs
[381.557645] Subtest debugfs: SUCCESS (0.000s)
[381.635207] [083/156] (640s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[381.740863] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[388.623192] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.887s)
[388.737406] [084/156] (633s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[388.831165] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[388.833360] Starting dynamic subtest: pipe-A-eDP-1
[388.858688] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.871157] Starting dynamic subtest: pipe-B-eDP-1
[388.894992] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.904613] Starting dynamic subtest: pipe-C-eDP-1
[388.927965] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.937460] Starting dynamic subtest: pipe-D-eDP-1
[388.961396] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.965788] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[391.105419] [085/156] (630s left) kms_flip (2x-flip-vs-dpms-on-nop)
[391.199366] Starting subtest: 2x-flip-vs-dpms-on-nop
[391.211924] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.012s)
[391.302317] [086/156] (630s left) syncobj_wait (wait-any-interrupted)
[391.360469] Starting subtest: wait-any-interrupted
[391.465987] Subtest wait-any-interrupted: SUCCESS (0.104s)
[391.555913] [087/156] (630s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[391.652410] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[391.656722] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[391.724649] [088/156] (630s left) perf (gen12-group-concurrent-oa-buffer-read)
[391.850732] Starting subtest: gen12-group-concurrent-oa-buffer-read
[401.878482] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.026s)
[401.929597] [089/156] (620s left) gem_eio (in-flight-contexts-immediate)
[402.187221] Starting subtest: in-flight-contexts-immediate
[416.359449] Subtest in-flight-contexts-immediate: SUCCESS (14.172s)
[416.483603] [090/156] (605s left) kms_pm_rpm (cursor)
[418.422388] Starting subtest: cursor
[418.427057] Subtest cursor: SKIP (0.000s)
[418.818356] [091/156] (603s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[418.946691] Starting subtest: cursor-vs-flip-atomic
[448.685298] Subtest cursor-vs-flip-atomic: SUCCESS (29.735s)
[449.561662] [092/156] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[449.684208] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[456.330035] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.649s)
[456.485461] [093/156] (565s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[456.596431] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[456.600469] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[456.696642] [094/156] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[456.802115] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[456.806274] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[456.917633] [095/156] (565s left) kms_psr2_su (page_flip-p010)
[456.979589] Subtest page_flip-P010: SKIP (0.000s)
[457.047272] [096/156] (565s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[457.130974] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[457.133262] Starting dynamic subtest: pipe-A-eDP-1
[457.667844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.514s)
[457.678783] Starting dynamic subtest: pipe-B-eDP-1
[459.226191] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[459.237834] Starting dynamic subtest: pipe-C-eDP-1
[460.664748] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.439s)
[460.677732] Starting dynamic subtest: pipe-D-eDP-1
[462.084610] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s)
[462.086617] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.927s)
[463.309159] [097/156] (559s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[463.410317] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[464.101506] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[464.269390] [098/156] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[464.375353] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[464.379580] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.468476] [099/156] (558s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[464.560777] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[464.565076] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[464.653896] [100/156] (558s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[464.769571] Starting subtest: cursorB-vs-flipA-varying-size
[464.774132] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[464.915151] [101/156] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[465.017203] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[472.121226] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.107s)
[472.238668] [102/156] (550s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[472.343099] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[472.347206] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[472.450986] [103/156] (550s left) gem_exec_reloc (basic-wc-read)
[472.508414] Subtest basic-wc-read: SKIP (0.000s)
[472.582909] [104/156] (550s left) kms_cursor_crc (cursor-random-256x256)
[472.826074] Starting subtest: cursor-random-256x256
[472.830924] Starting dynamic subtest: pipe-A-eDP-1
[476.194077] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.362s)
[476.227195] Starting dynamic subtest: pipe-D-eDP-1
[480.269593] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.049s)
[480.271516] Subtest cursor-random-256x256: SUCCESS (7.441s)
[481.096601] [105/156] (541s left) kms_color_pipeline (plane-lut1d-lut1d)
[481.194909] Starting subtest: plane-lut1d-lut1d
[481.363125] Starting dynamic subtest: pipe-A-plane-0
[481.551621] Dynamic subtest pipe-A-plane-0: SUCCESS (0.188s)
[481.563108] Starting dynamic subtest: pipe-A-plane-1
[481.741629] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[481.752565] Starting dynamic subtest: pipe-A-plane-2
[481.908393] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[483.145709] Starting dynamic subtest: pipe-B-plane-0
[483.325655] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[483.337097] Starting dynamic subtest: pipe-B-plane-1
[483.503619] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[483.515956] Starting dynamic subtest: pipe-B-plane-2
[483.693473] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[484.955067] Starting dynamic subtest: pipe-C-plane-0
[485.111329] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[485.122474] Starting dynamic subtest: pipe-C-plane-1
[485.278486] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[485.289270] Starting dynamic subtest: pipe-C-plane-2
[485.444586] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[486.687080] Starting dynamic subtest: pipe-D-plane-0
[486.844451] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[486.856319] Starting dynamic subtest: pipe-D-plane-1
[487.011124] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[487.021933] Starting dynamic subtest: pipe-D-plane-2
[487.168896] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[487.477564] Subtest plane-lut1d-lut1d: SUCCESS (6.282s)
[488.334674] [106/156] (534s left) gem_create (create-ext-placement-sanity-check)
[488.505272] Starting subtest: create-ext-placement-sanity-check
[488.507682] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[488.601391] [107/156] (534s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[488.699953] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[488.704259] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[488.794472] [108/156] (534s left) kms_plane (pixel-format-yf-tiled-modifier)
[488.882384] Starting subtest: pixel-format-yf-tiled-modifier
[488.886487] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[488.959968] [109/156] (534s left) gem_exec_params (dr1-dirt)
[489.012601] Starting subtest: DR1-dirt
[489.015089] Subtest DR1-dirt: SUCCESS (0.000s)
[489.108909] [110/156] (534s left) fbdev (eof)
[489.149032] Starting subtest: eof
[489.151282] Subtest eof: SUCCESS (0.000s)
[489.228774] [111/156] (533s left) i915_drm_fdinfo (memory-info-active)
[489.269020] Starting subtest: memory-info-active
[489.271386] Starting dynamic subtest: smem0
[491.990552] Dynamic subtest smem0: SUCCESS (2.722s)
[491.993268] Subtest memory-info-active: SUCCESS (2.724s)
[492.069977] [112/156] (531s left) kms_addfb_basic (unused-handle)
[492.131965] Starting subtest: unused-handle
[492.133833] Subtest unused-handle: SUCCESS (0.000s)
[492.279218] [113/156] (530s left) gem_exec_schedule (pi-ringfull)
[492.458716] Starting subtest: pi-ringfull
[492.461167] Starting dynamic subtest: rcs0
[492.494065] Dynamic subtest rcs0: SUCCESS (0.038s)
[492.504727] Starting dynamic subtest: bcs0
[492.535413] Dynamic subtest bcs0: SUCCESS (0.040s)
[492.549198] Starting dynamic subtest: vcs0
[492.571087] Dynamic subtest vcs0: SUCCESS (0.035s)
[492.586481] Starting dynamic subtest: vcs1
[492.603954] Dynamic subtest vcs1: SUCCESS (0.032s)
[492.619066] Starting dynamic subtest: vecs0
[492.632149] Dynamic subtest vecs0: SUCCESS (0.027s)
[492.647838] Starting dynamic subtest: ccs0
[492.661346] Dynamic subtest ccs0: SUCCESS (0.029s)
[492.663568] Subtest pi-ringfull: SUCCESS (0.207s)
[492.905420] [114/156] (530s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[493.011490] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[493.015544] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[493.123598] [115/156] (530s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[493.228837] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[493.233252] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[493.331255] [116/156] (530s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[493.439064] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[493.441447] Starting dynamic subtest: pipe-A
[493.551623] Dynamic subtest pipe-A: SKIP (0.109s)
[493.563156] Starting dynamic subtest: pipe-B
[494.703069] Dynamic subtest pipe-B: SKIP (1.149s)
[494.714449] Starting dynamic subtest: pipe-C
[495.941085] Dynamic subtest pipe-C: SUCCESS (1.244s)
[495.953065] Starting dynamic subtest: pipe-D
[497.200193] Dynamic subtest pipe-D: SUCCESS (1.258s)
[497.202396] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.764s)
[498.375627] [117/156] (525s left) gem_render_copy_redux (normal)
[498.432830] Starting subtest: normal
[498.744395] Subtest normal: SUCCESS (0.309s)
[498.852819] [118/156] (524s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[498.956735] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[498.960927] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[499.056505] [119/156] (524s left) kms_cursor_crc (cursor-sliding-max-size)
[499.397187] Starting subtest: cursor-sliding-max-size
[499.402677] Subtest cursor-sliding-max-size: SKIP (0.000s)
[499.517082] [120/156] (524s left) kms_getfb (getfb-handle-valid)
[499.611178] Starting subtest: getfb-handle-valid
[499.612959] Subtest getfb-handle-valid: SUCCESS (0.000s)
[499.710371] [121/156] (523s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen)
[499.797876] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen
[499.801138] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[499.916461] [122/156] (523s left) syncobj_basic (create-signaled)
[499.960372] Starting subtest: create-signaled
[499.962165] Subtest create-signaled: SUCCESS (0.000s)
[500.056451] [123/156] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[500.155283] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[500.158837] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[500.263283] [124/156] (523s left) api_intel_bb (object-reloc-keep-cache)
[500.311947] Starting subtest: object-reloc-keep-cache
[500.315842] Subtest object-reloc-keep-cache: SKIP (0.003s)
[500.424965] [125/156] (523s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[500.511551] Starting subtest: pr-primary-plane-update-sf-dmg-area
[500.514795] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[500.581119] [126/156] (523s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[500.670994] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[500.674704] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[500.764853] [127/156] (523s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[500.855389] Starting subtest: hdr-modesetfrombusy
[500.858941] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[500.949858] [128/156] (522s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[501.049497] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[501.051461] Starting dynamic subtest: pipe-A-eDP-1
[501.070338] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.081185] Starting dynamic subtest: pipe-B-eDP-1
[501.098727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.108422] Starting dynamic subtest: pipe-C-eDP-1
[501.125750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.134947] Starting dynamic subtest: pipe-D-eDP-1
[501.153099] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.156636] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[503.346302] [129/156] (520s left) i915_pm_rpm (debugfs-read)
[505.481480] Starting subtest: debugfs-read
[506.653087] Subtest debugfs-read: SUCCESS (1.171s)
[507.058272] [130/156] (516s left) sysfs_defaults (readonly)
[507.115531] Starting subtest: readonly
[507.117935] Starting dynamic subtest: vecs0
[507.120299] Dynamic subtest vecs0: SUCCESS (0.000s)
[507.132141] Starting dynamic subtest: ccs0
[507.134372] Dynamic subtest ccs0: SUCCESS (0.000s)
[507.144836] Starting dynamic subtest: vcs0
[507.147099] Dynamic subtest vcs0: SUCCESS (0.000s)
[507.157305] Starting dynamic subtest: bcs0
[507.159587] Dynamic subtest bcs0: SUCCESS (0.000s)
[507.171247] Starting dynamic subtest: rcs0
[507.173470] Dynamic subtest rcs0: SUCCESS (0.000s)
[507.185993] Starting dynamic subtest: vcs1
[507.188222] Dynamic subtest vcs1: SUCCESS (0.000s)
[507.190447] Subtest readonly: SUCCESS (0.006s)
[507.240768] [131/156] (516s left) api_intel_bb (add-remove-objects)
[507.294055] Starting subtest: add-remove-objects
[507.298882] Subtest add-remove-objects: SUCCESS (0.007s)
[507.389747] [132/156] (516s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[507.444631] Starting subtest: multi-wait-all-for-submit-signaled
[507.447214] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[507.530967] [133/156] (516s left) kms_3d (basic)
[507.587253] Starting subtest: basic
[509.850080] Subtest basic: SUCCESS (2.268s)
[510.344065] [134/156] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[510.439955] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[517.568749] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.132s)
[517.688872] [135/156] (506s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[517.785664] Starting subtest: psrhdr-shrfb-scaledprimary
[517.789943] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[517.872357] [136/156] (506s left) kms_flip (absolute-wf_vblank-interruptible)
[517.965467] Starting subtest: absolute-wf_vblank-interruptible
[517.967687] Starting dynamic subtest: A-eDP1
[526.706999] Dynamic subtest A-eDP1: SUCCESS (8.739s)
[526.719511] Starting dynamic subtest: B-eDP1
[535.407623] Dynamic subtest B-eDP1: SUCCESS (8.697s)
[535.420954] Starting dynamic subtest: C-eDP1
[544.094451] Dynamic subtest C-eDP1: SUCCESS (8.686s)
[544.105179] Starting dynamic subtest: D-eDP1
[552.795855] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[552.798161] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.833s)
[553.993254] [137/156] (470s left) kms_pm_rpm (system-suspend-idle)
[555.528435] Starting subtest: system-suspend-idle
[578.146215] Subtest system-suspend-idle: SUCCESS (7.457s)
[578.569708] [138/156] (445s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[578.700025] Starting subtest: fbcpsrhdr-stridechange
[578.704173] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[578.784873] [139/156] (445s left) gem_ctx_persistence (many-contexts)
[578.849695] Starting subtest: many-contexts
[616.715456] Subtest many-contexts: SUCCESS (37.682s)
[616.817235] [140/156] (407s left) kms_busy (basic)
[616.928755] Starting subtest: basic
[616.930952] Starting dynamic subtest: flip
[617.508779] Dynamic subtest flip: SUCCESS (0.581s)
[617.521195] Starting dynamic subtest: modeset
[621.296624] Dynamic subtest modeset: SUCCESS (3.782s)
[621.299008] Subtest basic: SUCCESS (4.365s)
[622.164566] [141/156] (402s left) kms_dp_aux_dev (basic)
[622.217548] Starting subtest: basic
[622.441414] Subtest basic: SUCCESS (0.223s)
[622.516737] [142/156] (402s left) kms_invalid_mode (zero-clock)
[622.610144] Starting subtest: zero-clock
[622.612467] Starting dynamic subtest: pipe-A-eDP-1
[622.891442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[622.903956] Starting dynamic subtest: pipe-B-eDP-1
[622.905903] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[622.917852] Starting dynamic subtest: pipe-C-eDP-1
[622.920277] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[622.931752] Starting dynamic subtest: pipe-D-eDP-1
[622.934189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[622.936439] Subtest zero-clock: SUCCESS (0.289s)
[623.761123] [143/156] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[623.868937] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[623.872989] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[623.963318] [144/156] (400s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[624.072459] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[624.076624] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[624.178783] [145/156] (400s left) i915_module_load (resize-bar)
[624.219173] Starting subtest: resize-bar
[624.225919] Subtest resize-bar: SKIP (0.006s)
[624.273882] [146/156] (400s left) gem_exec_fence (concurrent)
[624.459154] Starting subtest: concurrent
[624.463828] Subtest concurrent: SKIP (0.000s)
[626.405666] [147/156] (398s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[626.528154] Starting subtest: flip-vs-cursor-toggle
[635.586158] Subtest flip-vs-cursor-toggle: SUCCESS (9.052s)
[636.467984] [148/156] (388s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[636.527461] Starting subtest: y-tiled-to-vebox-yf-tiled
[636.531977] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[636.711936] [149/156] (388s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[636.805918] Starting subtest: primary-yf-tiled-reflect-x-90
[636.810155] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[636.882153] [150/156] (387s left) kms_cursor_crc (cursor-offscreen-128x42)
[637.116697] Starting subtest: cursor-offscreen-128x42
[637.169931] Subtest cursor-offscreen-128x42: SKIP (0.049s)
[637.376497] [151/156] (387s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[637.425847] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[637.535177] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[637.616226] [152/156] (387s left) gem_exec_alignment (pi)
[637.672756] Starting subtest: pi
[691.508534] Subtest pi: SUCCESS (53.822s)
[692.454023] [153/156] (332s left) gem_eio (wait-1us)
[692.744912] Starting subtest: wait-1us
[693.123745] Subtest wait-1us: SUCCESS (0.382s)
[693.256065] [154/156] (331s left) gem_readwrite (read-write)
[693.324812] Subtest read-write: SKIP (0.000s)
[693.392755] [155/156] (331s left) kms_lease (lease-unleased-connector)
[693.490407] Starting subtest: lease-unleased-connector
[693.491956] Starting dynamic subtest: pipe-A-eDP-1
[693.498663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[693.512293] Starting dynamic subtest: pipe-B-eDP-1
[693.514099] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[693.526553] Starting dynamic subtest: pipe-C-eDP-1
[693.528290] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[693.539216] Starting dynamic subtest: pipe-D-eDP-1
[693.540954] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[693.542706] Subtest lease-unleased-connector: SUCCESS (0.035s)
[693.629642] [156/156] (331s left) gem_exec_schedule (u-semaphore-user)
[693.694386] Starting subtest: u-semaphore-user
[693.748203] Subtest u-semaphore-user: SUCCESS (0.058s)
[695.355698] Closing watchdogs
results: parsing output: 0/ for test: drm_read
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gen9_exec_parse
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_atomic_transition
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_chamelium_frames
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: device_reset
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_pread
results: parsing output: 38/ for test: kms_plane_lowres
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: sriov_basic
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_exec_gttfill
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_vm_create
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_draw_crc
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: i915_query
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_rmfb
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: gem_exec_await
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_exec_create
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr2_su
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_color_pipeline
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: fbdev
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_render_copy_redux
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: sysfs_defaults
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_3d
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_flip
results: parsing output: 136/ for test: kms_pm_rpm
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_ctx_persistence
results: parsing output: 139/ for test: kms_busy
results: parsing output: 140/ for test: kms_dp_aux_dev
results: parsing output: 141/ for test: kms_invalid_mode
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: i915_module_load
results: parsing output: 145/ for test: gem_exec_fence
results: parsing output: 146/ for test: kms_cursor_legacy
results: parsing output: 147/ for test: gem_render_copy
results: parsing output: 148/ for test: kms_rotation_crc
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: gem_exec_alignment
results: parsing output: 152/ for test: gem_eio
results: parsing output: 153/ for test: gem_readwrite
results: parsing output: 154/ for test: kms_lease
results: parsing output: 155/ for test: gem_exec_schedule
Done.