[56.588369] Initializing watchdogs
[56.588416]   /dev/watchdog0
[56.603907] [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]
[56.608214] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.610355] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.613737] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.715522] Subtest write-snoop: SKIP (0.000s)
[56.807275] [002/133] (960s left) kms_content_protection (content-type-change)
[56.962084] Starting subtest: content-type-change
[56.966919] Subtest content-type-change: SKIP (0.000s)
[57.116953] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.216572] Starting subtest: multiplane-rotation
[74.518401] Subtest multiplane-rotation: SUCCESS (17.360s)
[74.667707] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[74.779225] Subtest ctm-red-to-blue: SKIP (0.000s)
[74.819225] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[74.886270] Starting subtest: invalid-reset-one-illegal-handle
[74.888212] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.016484] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.106071] Starting subtest: disable-crc-after-crtc
[75.108062] Starting dynamic subtest: pipe-A-eDP-1
[76.741662] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.635s)
[76.750652] Starting dynamic subtest: pipe-B-eDP-1
[79.011233] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.269s)
[79.018917] Starting dynamic subtest: pipe-C-eDP-1
[81.260681] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.248s)
[81.271435] Starting dynamic subtest: pipe-D-eDP-1
[83.525180] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[83.527358] Subtest disable-crc-after-crtc: SUCCESS (8.418s)
[84.363288] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.430775] Subtest tiled-to-tiled: SKIP (0.000s)
[84.515649] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[84.574975] Starting subtest: wait-all-interrupted
[84.677886] Subtest wait-all-interrupted: SUCCESS (0.102s)
[84.771387] [009/133] (932s left) syncobj_wait (wait-all-complex)
[84.819192] Starting subtest: wait-all-complex
[85.034091] Subtest wait-all-complex: SUCCESS (0.214s)
[85.131568] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.261511] Starting subtest: reject-modify-context-protection-on
[85.263929] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.387473] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[85.513837] Starting subtest: cursorA-vs-flipB-varying-size
[85.518371] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[85.680844] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[85.776090] Starting subtest: primary-rotation-90
[85.780564] Subtest primary-rotation-90: SKIP (0.001s)
[85.873741] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[85.928084] Starting subtest: reset-multiple-signaled
[85.930377] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.037947] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.136338] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.139914] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.295081] [015/133] (930s left) gem_softpin (noreloc-s3)
[87.368342] Starting subtest: noreloc-S3
[107.699450] Subtest noreloc-S3: SUCCESS (5.409s)
[107.878323] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[108.007720] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[112.346503] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.412s)
[113.518455] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[113.581282] Starting subtest: invalid-ctx-set
[113.583768] Subtest invalid-ctx-set: SUCCESS (0.002s)
[113.723735] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[113.779246] Starting subtest: single-wait-all-for-submit-unsubmitted
[113.880663] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[113.980724] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[114.078033] Starting subtest: x-tiled-64bpp-rotate-90
[114.097498] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[114.241477] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[114.300970] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[114.368701] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[114.464463] Starting subtest: fbc-psr-cursor-plane-move
[114.466265] Starting dynamic subtest: eDP-1
[114.470070] Dynamic subtest eDP-1: SKIP (0.000s)
[114.473957] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[114.555811] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[114.668966] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[115.639760] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s)
[115.769428] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[115.870662] Starting subtest: 2x-flip-vs-rmfb
[115.879361] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[116.019678] [024/133] (901s left) kms_plane_cursor (viewport)
[116.120558] Starting subtest: viewport
[116.124155] Starting dynamic subtest: pipe-A-eDP-1-size-64
[118.591234] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.485s)
[118.650052] Starting dynamic subtest: pipe-A-eDP-1-size-128
[121.215319] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.585s)
[121.271253] Starting dynamic subtest: pipe-A-eDP-1-size-256
[123.748251] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.493s)
[124.103625] Starting dynamic subtest: pipe-B-eDP-1-size-64
[127.324829] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.239s)
[127.381339] Starting dynamic subtest: pipe-B-eDP-1-size-128
[129.876946] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[129.936028] Starting dynamic subtest: pipe-B-eDP-1-size-256
[132.440869] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[132.789876] Starting dynamic subtest: pipe-C-eDP-1-size-64
[135.616567] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.838s)
[135.653776] Starting dynamic subtest: pipe-C-eDP-1-size-128
[137.784747] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.135s)
[137.821810] Starting dynamic subtest: pipe-C-eDP-1-size-256
[139.951335] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.135s)
[140.281028] Starting dynamic subtest: pipe-D-eDP-1-size-64
[143.109570] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.836s)
[143.151444] Starting dynamic subtest: pipe-D-eDP-1-size-128
[145.254451] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.112s)
[145.294158] Starting dynamic subtest: pipe-D-eDP-1-size-256
[147.387347] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[147.708109] Subtest viewport: SUCCESS (31.637s)
[148.553120] [025/133] (869s left) kms_cdclk (mode-transition)
[148.658534] Starting subtest: mode-transition
[148.660695] Starting dynamic subtest: pipe-A-eDP-1
[148.952804] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[148.961725] Starting dynamic subtest: pipe-B-eDP-1
[148.966754] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[148.974403] Starting dynamic subtest: pipe-C-eDP-1
[148.979090] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[148.986824] Starting dynamic subtest: pipe-D-eDP-1
[148.991537] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[148.996165] Subtest mode-transition: SKIP (0.311s)
[149.783162] [026/133] (868s left) gem_exec_balancer (fairslice)
[149.862970] Starting subtest: fairslice
[152.725092] Subtest fairslice: SUCCESS (2.863s)
[154.042265] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[154.167423] Starting subtest: basic-flip-before-cursor-varying-size
[155.104654] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.936s)
[155.915278] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[156.013964] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[156.018549] Starting dynamic subtest: pipe-A-default-mode
[156.317933] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[156.322306] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.302s)
[157.154216] [029/133] (861s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[157.259260] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[157.261348] Starting dynamic subtest: pipe-A-default-mode
[160.007148] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[160.009495] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.747s)
[160.861142] [030/133] (857s left) core_getstats (basic)
[160.928168] Starting subtest: basic
[160.930842] Subtest basic: SUCCESS (0.000s)
[161.076919] [031/133] (857s left) kms_rmfb (close-fd)
[161.182337] Starting subtest: close-fd
[161.184780] Starting dynamic subtest: pipe-A-eDP-1
[161.292646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[161.302171] Starting dynamic subtest: pipe-B-eDP-1
[162.502935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.209s)
[162.513176] Starting dynamic subtest: pipe-C-eDP-1
[163.634843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.132s)
[163.643767] Starting dynamic subtest: pipe-D-eDP-1
[164.773034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[164.775063] Subtest close-fd: SUCCESS (3.590s)
[166.010804] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[166.086054] Subtest basic-gtt-wc: SKIP (0.000s)
[166.157672] [033/133] (852s left) kms_properties (crtc-properties-legacy)
[166.247415] Starting subtest: crtc-properties-legacy
[166.249775] Starting dynamic subtest: pipe-A-eDP-1
[166.685976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[166.696424] Starting dynamic subtest: pipe-B-eDP-1
[167.840558] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[167.850054] Starting dynamic subtest: pipe-C-eDP-1
[168.964908] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[168.973964] Starting dynamic subtest: pipe-D-eDP-1
[170.093869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[170.095808] Subtest crtc-properties-legacy: SUCCESS (3.845s)
[170.907146] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[171.009676] Starting subtest: zero-hdisplay
[171.011936] Starting dynamic subtest: pipe-A-eDP-1
[171.295493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[171.307827] Starting dynamic subtest: pipe-B-eDP-1
[171.310007] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[171.320537] Starting dynamic subtest: pipe-C-eDP-1
[171.322731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[171.330717] Starting dynamic subtest: pipe-D-eDP-1
[171.332893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[171.335105] Subtest zero-hdisplay: SUCCESS (0.291s)
[172.138565] [035/133] (846s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[172.232321] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[172.234638] Starting dynamic subtest: pipe-A
[173.279665] Dynamic subtest pipe-A: SUCCESS (1.050s)
[173.295550] Starting dynamic subtest: pipe-B
[175.470289] Dynamic subtest pipe-B: SUCCESS (2.189s)
[175.478745] Starting dynamic subtest: pipe-C
[176.620793] Dynamic subtest pipe-C: SUCCESS (1.149s)
[176.633669] Starting dynamic subtest: pipe-D
[177.772352] Dynamic subtest pipe-D: SUCCESS (1.150s)
[177.774726] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.545s)
[178.999272] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[181.037613] Starting subtest: legacy-planes-dpms
[181.040127] Starting dynamic subtest: plane-63
[189.618943] Dynamic subtest plane-63: SUCCESS (8.583s)
[189.640739] Starting dynamic subtest: plane-93
[198.041969] Dynamic subtest plane-93: SUCCESS (8.422s)
[198.053497] Starting dynamic subtest: plane-123
[206.319932] Dynamic subtest plane-123: SUCCESS (8.272s)
[206.331729] Starting dynamic subtest: plane-133
[214.689809] Dynamic subtest plane-133: SUCCESS (8.364s)
[214.692909] Subtest legacy-planes-dpms: SUCCESS (33.653s)
[215.074581] [037/133] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[215.172881] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[215.177320] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.307005] [038/133] (803s left) kms_dirtyfb (default-dirtyfb-ioctl)
[215.409409] Starting subtest: default-dirtyfb-ioctl
[215.411682] Starting dynamic subtest: A-eDP-1
[217.035923] Dynamic subtest A-eDP-1: SUCCESS (1.621s)
[217.037845] Subtest default-dirtyfb-ioctl: SUCCESS (1.624s)
[217.898117] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[218.032394] Starting subtest: cursorB-vs-flipA-legacy
[218.036822] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[218.208431] [040/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[218.262931] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[218.264975] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[218.371177] [041/133] (800s left) kms_prime (basic-crc-vgem)
[218.509606] Starting subtest: basic-crc-vgem
[218.511451] Starting dynamic subtest: second-to-first
[219.511221] Dynamic subtest second-to-first: SUCCESS (1.003s)
[219.513363] Subtest basic-crc-vgem: SUCCESS (1.004s)
[219.625934] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[219.629170] [042/133] (799s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[219.730399] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[219.787116] [043/133] (798s left) i915_drm_fdinfo (busy)
[219.828705] Starting subtest: busy
[219.830553] Starting dynamic subtest: rcs0
[219.859327] Dynamic subtest rcs0: SKIP (0.029s)
[219.870132] Starting dynamic subtest: bcs0
[219.874022] Dynamic subtest bcs0: SKIP (0.000s)
[219.886829] Starting dynamic subtest: vcs0
[219.890665] Dynamic subtest vcs0: SKIP (0.000s)
[219.898562] Starting dynamic subtest: vcs1
[219.902132] Dynamic subtest vcs1: SKIP (0.000s)
[219.909875] Starting dynamic subtest: vecs0
[219.913501] Dynamic subtest vecs0: SKIP (0.000s)
[219.921041] Starting dynamic subtest: ccs0
[219.924689] Dynamic subtest ccs0: SKIP (0.000s)
[219.928278] Subtest busy: SKIP (0.035s)
[219.961920] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[220.034391] Starting subtest: nohangcheck
[220.298413] Subtest nohangcheck: SUCCESS (0.262s)
[220.457901] [045/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[220.570921] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[221.172750] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[221.411580] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[221.509356] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[221.513863] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[222.641323] [047/133] (796s left) kms_scaling_modes (scaling-mode-full)
[222.730358] Starting subtest: scaling-mode-full
[222.732564] Starting dynamic subtest: pipe-A-eDP-1
[222.829942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.101s)
[222.839224] Starting dynamic subtest: pipe-B-eDP-1
[224.045553] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[224.058711] Starting dynamic subtest: pipe-C-eDP-1
[225.163311] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[225.172099] Starting dynamic subtest: pipe-D-eDP-1
[226.287841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[226.290177] Subtest scaling-mode-full: SUCCESS (3.560s)
[227.472591] [048/133] (791s left) kms_psr (fbc-pr-basic)
[227.583467] Starting subtest: fbc-pr-basic
[227.587901] Subtest fbc-pr-basic: SKIP (0.000s)
[227.680024] [049/133] (791s left) gem_ringfill (basic-all)
[232.896018] Starting subtest: basic-all
[234.075893] Subtest basic-all: SUCCESS (1.179s)
[234.249487] [050/133] (784s left) gem_exec_whisper (basic-fds-forked-all)
[234.315533] Starting subtest: basic-fds-forked-all
[256.316339] Subtest basic-fds-forked-all: SUCCESS (21.998s)
[256.521463] [051/133] (762s left) api_intel_bb (full-batch)
[256.582583] Starting subtest: full-batch
[256.589790] Subtest full-batch: SUCCESS (0.010s)
[256.712836] [052/133] (762s left) kms_cursor_crc (cursor-sliding-256x85)
[256.956094] Starting subtest: cursor-sliding-256x85
[257.002572] Subtest cursor-sliding-256x85: SKIP (0.041s)
[257.218770] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[257.324067] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[257.326320] Starting dynamic subtest: pipe-A-eDP-1
[257.382332] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.390987] Starting dynamic subtest: pipe-B-eDP-1
[257.443396] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[257.451652] Starting dynamic subtest: pipe-C-eDP-1
[257.496093] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[257.504266] Starting dynamic subtest: pipe-D-eDP-1
[257.548312] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[257.551719] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[259.537063] [054/133] (759s left) gen9_exec_parse (allowed-single)
[259.591729] Subtest allowed-single: SKIP (0.000s)
[259.674563] [055/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[259.795451] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[266.870000] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.076s)
[267.004204] [056/133] (752s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[267.119567] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[267.123878] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[267.243832] [057/133] (752s left) gem_exec_fence (expired-history)
[267.737980] Starting subtest: expired-history
[274.705219] Subtest expired-history: SUCCESS (6.969s)
[276.369227] [058/133] (742s left) kms_psr (fbc-psr-sprite-plane-move)
[276.471076] Starting subtest: fbc-psr-sprite-plane-move
[276.473126] Starting dynamic subtest: eDP-1
[276.477446] Dynamic subtest eDP-1: SKIP (0.000s)
[276.481650] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[276.577836] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.669140] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[283.412079] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.747s)
[283.574263] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[283.629153] Starting subtest: double-destroy
[283.631628] Subtest double-destroy: SUCCESS (0.000s)
[283.727449] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[283.793596] Starting subtest: invalid-signal-illegal-handle
[283.795501] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[283.923298] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[284.307062] Subtest common-hpd-after-suspend: SKIP (0.000s)
[285.158702] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[285.266376] Starting subtest: fbc-tiling-4
[289.491524] Subtest fbc-tiling-4: SUCCESS (4.228s)
[290.709719] [064/133] (728s left) gem_cs_tlb (engines)
[290.764951] Starting subtest: engines
[290.767194] Starting dynamic subtest: rcs0
[292.973904] Dynamic subtest rcs0: SUCCESS (2.152s)
[292.985312] Starting dynamic subtest: bcs0
[295.071058] Dynamic subtest bcs0: SUCCESS (2.150s)
[295.082522] Starting dynamic subtest: vcs0
[297.274884] Dynamic subtest vcs0: SUCCESS (2.151s)
[297.284757] Starting dynamic subtest: vcs1
[299.425765] Dynamic subtest vcs1: SUCCESS (2.151s)
[299.437318] Starting dynamic subtest: vecs0
[301.579666] Dynamic subtest vecs0: SUCCESS (2.153s)
[301.591554] Starting dynamic subtest: ccs0
[303.730399] Dynamic subtest ccs0: SUCCESS (2.151s)
[303.732823] Subtest engines: SUCCESS (12.913s)
[303.866933] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[303.931461] Subtest hang-busy: SKIP (0.000s)
[303.999413] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[304.102183] Starting subtest: psr2-sprite-plane-onoff
[304.104554] Starting dynamic subtest: eDP-1
[305.811156] Dynamic subtest eDP-1: SUCCESS (1.709s)
[305.813546] Subtest psr2-sprite-plane-onoff: SUCCESS (1.710s)
[306.673392] [067/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[306.780921] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[307.404611] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[307.578445] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.682794] Starting subtest: y-tiled-64bpp-rotate-270
[307.686853] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[307.823727] [069/133] (711s left) gem_bad_reloc (negative-reloc-lut)
[307.888130] Subtest negative-reloc-lut: SKIP (0.000s)
[307.960889] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[308.019450] Starting subtest: engines-mixed
[308.021653] Starting dynamic subtest: rcs0
[308.155077] Dynamic subtest rcs0: SUCCESS (0.138s)
[308.167518] Starting dynamic subtest: bcs0
[308.220998] Dynamic subtest bcs0: SUCCESS (0.064s)
[308.232094] Starting dynamic subtest: vcs0
[308.293703] Dynamic subtest vcs0: SUCCESS (0.071s)
[308.305810] Starting dynamic subtest: vcs1
[308.364754] Dynamic subtest vcs1: SUCCESS (0.069s)
[308.376871] Starting dynamic subtest: vecs0
[308.446868] Dynamic subtest vecs0: SUCCESS (0.080s)
[308.457688] Starting dynamic subtest: ccs0
[308.518879] Dynamic subtest ccs0: SUCCESS (0.070s)
[308.521266] Subtest engines-mixed: SUCCESS (0.504s)
[308.621269] [071/133] (711s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[308.709627] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[308.711397] Starting dynamic subtest: pipe-A
[308.778704] Dynamic subtest pipe-A: SUCCESS (0.069s)
[308.789912] Starting dynamic subtest: pipe-B
[309.903940] Dynamic subtest pipe-B: SUCCESS (1.123s)
[309.914778] Starting dynamic subtest: pipe-C
[311.022728] Dynamic subtest pipe-C: SUCCESS (1.118s)
[311.032868] Starting dynamic subtest: pipe-D
[312.154309] Dynamic subtest pipe-D: SUCCESS (1.131s)
[312.156634] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.447s)
[313.328487] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.434903] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.439225] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.571014] [073/133] (706s left) gem_exec_schedule (semaphore-noskip)
[313.655461] Starting subtest: semaphore-noskip
[314.094012] Subtest semaphore-noskip: SUCCESS (0.440s)
[314.489235] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[314.598178] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[314.602215] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.726140] [075/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[314.826376] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[314.830333] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[314.942564] [076/133] (705s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[315.066042] Starting subtest: 4-tiled-16bpp-rotate-0
[316.398505] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.334s)
[316.595921] [077/133] (703s left) gem_exec_basic (basic)
[316.661638] Starting subtest: basic
[316.663658] Starting dynamic subtest: rcs0-smem
[316.665697] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[316.675858] Starting dynamic subtest: bcs0-smem
[316.677862] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[316.686122] Starting dynamic subtest: vcs0-smem
[316.688022] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.696113] Starting dynamic subtest: vcs1-smem
[316.697993] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[316.706378] Starting dynamic subtest: vecs0-smem
[316.708245] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[316.716530] Starting dynamic subtest: ccs0-smem
[316.718312] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[316.720095] Subtest basic: SUCCESS (0.015s)
[318.015843] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[318.110907] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[318.115048] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.269252] [079/133] (701s left) gem_mmap (short-mmap)
[318.329673] Subtest short-mmap: SKIP (0.000s)
[318.389458] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[318.444730] Subtest basic-gtt-wc-active: SKIP (0.000s)
[318.521562] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[318.585817] Starting subtest: create-shared-gtt
[320.737691] Subtest create-shared-gtt: SUCCESS (2.151s)
[321.217578] [082/133] (699s left) gem_exec_reloc (basic-write-wc)
[321.280184] Subtest basic-write-wc: SKIP (0.000s)
[321.356662] [083/133] (699s left) gem_eio (wait-immediate)
[321.592355] Starting subtest: wait-immediate
[321.976258] Subtest wait-immediate: SUCCESS (0.384s)
[322.141165] [084/133] (698s left) gem_ctx_persistence (legacy-engines-mixed)
[322.205012] Starting subtest: legacy-engines-mixed
[322.206672] Starting dynamic subtest: render
[322.296430] Dynamic subtest render: SUCCESS (0.094s)
[322.308116] Starting dynamic subtest: bsd1
[322.376509] Dynamic subtest bsd1: SUCCESS (0.077s)
[322.389021] Starting dynamic subtest: bsd2
[322.447421] Dynamic subtest bsd2: SUCCESS (0.068s)
[322.461096] Starting dynamic subtest: blt
[322.530799] Dynamic subtest blt: SUCCESS (0.080s)
[322.544380] Starting dynamic subtest: vebox
[322.597957] Dynamic subtest vebox: SUCCESS (0.064s)
[322.600721] Subtest legacy-engines-mixed: SUCCESS (0.397s)
[322.710388] [085/133] (697s left) perf_pmu (semaphore-busy)
[322.749821] Starting subtest: semaphore-busy
[322.751838] Starting dynamic subtest: rcs0
[324.416428] Dynamic subtest rcs0: SUCCESS (1.662s)
[324.429081] Starting dynamic subtest: bcs0
[326.046371] Dynamic subtest bcs0: SUCCESS (1.629s)
[326.063147] Starting dynamic subtest: vcs0
[330.473662] Dynamic subtest vcs0: SUCCESS (4.374s)
[330.485737] Starting dynamic subtest: vcs1
[336.440536] Dynamic subtest vcs1: SUCCESS (6.011s)
[336.453027] Starting dynamic subtest: vecs0
[342.506222] Dynamic subtest vecs0: SUCCESS (6.010s)
[342.518079] Starting dynamic subtest: ccs0
[345.529436] Dynamic subtest ccs0: SUCCESS (3.071s)
[345.532003] Subtest semaphore-busy: SUCCESS (22.772s)
[345.681158] [086/133] (674s left) gem_exec_schedule (pi-common)
[345.860141] Starting subtest: pi-common
[345.862270] Starting dynamic subtest: rcs0
[345.898413] Dynamic subtest rcs0: SUCCESS (0.040s)
[345.908129] Starting dynamic subtest: bcs0
[345.939121] Dynamic subtest bcs0: SUCCESS (0.040s)
[345.948703] Starting dynamic subtest: vcs0
[345.974975] Dynamic subtest vcs0: SUCCESS (0.035s)
[345.984643] Starting dynamic subtest: vcs1
[346.011417] Dynamic subtest vcs1: SUCCESS (0.035s)
[346.020563] Starting dynamic subtest: vecs0
[346.043785] Dynamic subtest vecs0: SUCCESS (0.032s)
[346.053268] Starting dynamic subtest: ccs0
[346.076261] Dynamic subtest ccs0: SUCCESS (0.032s)
[346.078475] Subtest pi-common: SUCCESS (0.219s)
[346.331972] [087/133] (674s left) i915_hangman (engine-error-state-capture)
[346.403663] Starting subtest: engine-error-state-capture
[346.405903] Starting dynamic subtest: rcs0
[349.915265] Dynamic subtest rcs0: SUCCESS (3.509s)
[349.928169] Starting dynamic subtest: bcs0
[355.867719] Dynamic subtest bcs0: SUCCESS (5.949s)
[355.880858] Starting dynamic subtest: vcs0
[361.819451] Dynamic subtest vcs0: SUCCESS (5.946s)
[361.832283] Starting dynamic subtest: vcs1
[366.811272] Dynamic subtest vcs1: SUCCESS (4.988s)
[366.824110] Starting dynamic subtest: vecs0
[371.867656] Dynamic subtest vecs0: SUCCESS (5.053s)
[371.880039] Starting dynamic subtest: ccs0
[377.883700] Dynamic subtest ccs0: SUCCESS (6.012s)
[377.887730] Subtest engine-error-state-capture: SUCCESS (31.475s)
[377.988995] [088/133] (642s left) syncobj_timeline (wait-for-submit-snapshot)
[378.052720] Starting subtest: wait-for-submit-snapshot
[378.133286] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[378.238467] [089/133] (642s left) kms_color (ctm-blue-to-red)
[378.343227] Starting subtest: ctm-blue-to-red
[378.345380] Starting dynamic subtest: pipe-A-eDP-1
[379.062716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[379.072894] Starting dynamic subtest: pipe-B-eDP-1
[380.488401] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[380.498369] Starting dynamic subtest: pipe-C-eDP-1
[381.767903] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[381.777502] Starting dynamic subtest: pipe-D-eDP-1
[383.100421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[383.102699] Subtest ctm-blue-to-red: SUCCESS (4.757s)
[383.967680] [090/133] (636s left) prime_vgem (basic-gtt)
[384.050346] Starting subtest: basic-gtt
[384.054887] Subtest basic-gtt: SKIP (0.000s)
[384.196687] [091/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[384.292488] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[391.650438] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.360s)
[391.831390] [092/133] (628s left) api_intel_allocator (default-alignment)
[391.898103] Starting subtest: default-alignment
[391.900401] Subtest default-alignment: SUCCESS (0.003s)
[392.060076] [093/133] (628s left) i915_pm_rps (fence-order)
[392.123299] Starting subtest: fence-order
[395.054159] Subtest fence-order: SUCCESS (2.928s)
[395.199247] [094/133] (625s left) kms_vblank (query-busy)
[395.300142] Starting subtest: query-busy
[395.302424] Starting dynamic subtest: pipe-A-eDP-1
[397.184749] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[397.200031] Starting dynamic subtest: pipe-D-eDP-1
[399.710092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[399.712420] Subtest query-busy: SUCCESS (4.413s)
[400.532280] [095/133] (620s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[400.633453] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[400.637815] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[400.765183] [096/133] (620s left) kms_addfb_basic (invalid-get-prop-any)
[400.831703] Starting subtest: invalid-get-prop-any
[400.833966] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[401.010919] [097/133] (619s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[401.110718] Starting subtest: fbc-psr2-cursor-mmap-gtt
[401.112939] Starting dynamic subtest: eDP-1
[401.117384] Dynamic subtest eDP-1: SKIP (0.000s)
[401.121803] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[401.209606] [098/133] (619s left) kms_flip (2x-blocking-absolute-wf_vblank)
[401.307509] Starting subtest: 2x-blocking-absolute-wf_vblank
[401.316258] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[401.418396] [099/133] (619s left) kms_cursor_crc (cursor-onscreen-256x85)
[401.680012] Starting subtest: cursor-onscreen-256x85
[401.726085] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[401.920844] [100/133] (619s left) kms_flip (2x-modeset-vs-vblank-race)
[402.015558] Starting subtest: 2x-modeset-vs-vblank-race
[402.026694] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[402.133273] [101/133] (618s left) kms_atomic_interruptible (atomic-setmode)
[402.237643] Starting subtest: atomic-setmode
[402.239427] Starting dynamic subtest: pipe-A-eDP-1
[409.140450] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.902s)
[409.142834] Subtest atomic-setmode: SUCCESS (6.903s)
[410.037650] [102/133] (611s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[410.137180] Starting subtest: psr-argb161616f-draw-render
[410.141536] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[410.264352] [103/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[410.372567] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[410.376895] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.513831] [104/133] (610s left) kms_plane_scaling (invalid-num-scalers)
[410.595219] Starting subtest: invalid-num-scalers
[410.597467] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[410.613290] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[410.622802] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[410.644629] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[410.653840] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[410.676584] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[410.686390] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[410.708377] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[410.710675] Subtest invalid-num-scalers: SUCCESS (0.115s)
[410.847853] [105/133] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[410.958665] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[410.962277] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[411.101999] [106/133] (610s left) sw_sync (alloc_fence_invalid_timeline)
[411.144009] Starting subtest: alloc_fence_invalid_timeline
[411.146220] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[411.231976] [107/133] (610s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[411.285354] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[411.394052] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[411.495839] [108/133] (609s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[411.595773] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[411.598136] Starting dynamic subtest: A-eDP1
[420.466522] Dynamic subtest A-eDP1: SUCCESS (8.870s)
[420.478765] Starting dynamic subtest: B-eDP1
[429.395696] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[429.405774] Starting dynamic subtest: C-eDP1
[438.350840] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[438.362867] Starting dynamic subtest: D-eDP1
[447.281098] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[447.283565] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.642s)
[448.479449] [109/133] (572s left) kms_addfb_basic (size-max)
[448.579073] Starting subtest: size-max
[448.581310] Subtest size-max: SUCCESS (0.000s)
[448.706934] [110/133] (572s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[448.950029] Starting subtest: cursor-rapid-movement-256x256
[448.955073] Starting dynamic subtest: pipe-A-eDP-1
[449.498511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[449.525291] Starting dynamic subtest: pipe-D-eDP-1
[450.665288] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.148s)
[450.668027] Subtest cursor-rapid-movement-256x256: SUCCESS (1.715s)
[451.544703] [111/133] (570s left) gem_exec_whisper (basic-queues-all)
[451.607051] Starting subtest: basic-queues-all
[460.829585] Subtest basic-queues-all: SUCCESS (9.219s)
[461.039816] [112/133] (560s left) kms_dsc (dsc-fractional-bpp)
[461.129325] Starting subtest: dsc-fractional-bpp
[461.142896] Subtest dsc-fractional-bpp: SKIP (0.000s)
[461.223321] [113/133] (560s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[461.320273] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[461.322435] Starting dynamic subtest: pipe-A-default-mode
[461.607710] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[461.612296] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.287s)
[462.468234] [114/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[462.573256] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[462.577368] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[462.706992] [115/133] (559s left) gem_softpin (evict-prime)
[462.778924] Starting subtest: evict-prime
[462.781260] Starting dynamic subtest: rcs0
[463.972121] Dynamic subtest rcs0: SUCCESS (1.193s)
[463.984516] Starting dynamic subtest: bcs0
[465.106188] Dynamic subtest bcs0: SUCCESS (1.132s)
[465.119219] Starting dynamic subtest: vcs0
[466.892147] Dynamic subtest vcs0: SUCCESS (1.783s)
[466.905048] Starting dynamic subtest: vcs1
[468.876706] Dynamic subtest vcs1: SUCCESS (1.982s)
[468.889025] Starting dynamic subtest: vecs0
[470.940316] Dynamic subtest vecs0: SUCCESS (2.061s)
[470.953203] Starting dynamic subtest: ccs0
[472.099539] Dynamic subtest ccs0: SUCCESS (1.159s)
[472.111876] Starting dynamic subtest: all
[473.954012] Dynamic subtest all: SUCCESS (1.851s)
[473.957229] Subtest evict-prime: SUCCESS (11.176s)
[474.062007] [116/133] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[474.189452] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[474.193437] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[474.320806] [117/133] (547s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[474.422470] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[474.541663] [118/133] (547s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[474.613329] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[474.721471] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[474.825794] [119/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[474.929410] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[474.933318] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[475.069887] [120/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[475.184757] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[479.216534] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.035s)
[480.380446] [121/133] (541s left) gem_mmap_wc (bad-size)
[480.448331] Subtest bad-size: SKIP (0.000s)
[480.512779] [122/133] (541s left) kms_hdr (static-toggle-suspend)
[480.606061] Starting subtest: static-toggle-suspend
[480.612505] Subtest static-toggle-suspend: SKIP (0.000s)
[480.704114] [123/133] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[480.801965] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[480.806187] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[480.963565] [124/133] (541s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[486.045425] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[486.047769] Starting dynamic subtest: pipe-A-eDP-1
[486.827318] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[486.837238] Starting dynamic subtest: pipe-B-eDP-1
[487.956236] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[487.960928] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.911s)
[489.149899] [125/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[489.241964] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[489.246407] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[489.356799] [126/133] (532s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[489.456164] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[489.458285] Starting dynamic subtest: pipe-A-eDP-1
[489.477707] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[489.489334] Starting dynamic subtest: pipe-B-eDP-1
[489.507371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[489.516176] Starting dynamic subtest: pipe-C-eDP-1
[489.535138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[489.544163] Starting dynamic subtest: pipe-D-eDP-1
[489.563449] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[489.565335] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[491.703606] [127/133] (530s left) syncobj_timeline (single-wait-all-available-submitted)
[491.767973] Starting subtest: single-wait-all-available-submitted
[491.770729] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[491.898222] [128/133] (530s left) gem_exec_parallel (userptr)
[491.955940] Starting subtest: userptr
[491.958352] Starting dynamic subtest: rcs0
[493.406387] Dynamic subtest rcs0: SUCCESS (1.450s)
[493.418478] Starting dynamic subtest: bcs0
[494.903742] Dynamic subtest bcs0: SUCCESS (1.496s)
[494.916093] Starting dynamic subtest: vcs0
[496.893299] Dynamic subtest vcs0: SUCCESS (1.986s)
[496.905008] Starting dynamic subtest: vcs1
[498.940543] Dynamic subtest vcs1: SUCCESS (2.045s)
[498.953500] Starting dynamic subtest: vecs0
[500.880858] Dynamic subtest vecs0: SUCCESS (1.938s)
[500.893583] Starting dynamic subtest: ccs0
[502.367629] Dynamic subtest ccs0: SUCCESS (1.486s)
[502.370005] Subtest userptr: SUCCESS (10.414s)
[502.577365] [129/133] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[502.670132] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[502.674906] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[502.786356] [130/133] (519s left) i915_selftest (mock)
[504.830624] Starting subtest: mock
[504.833078] Starting dynamic subtest: sanitycheck
[505.593111] Dynamic subtest sanitycheck: SUCCESS (0.763s)
[505.602488] Starting dynamic subtest: shmem
[506.330508] Dynamic subtest shmem: SUCCESS (0.736s)
[506.339908] Starting dynamic subtest: fence
[514.098234] Dynamic subtest fence: SUCCESS (7.766s)
[514.107996] Starting dynamic subtest: scatterlist
[515.826447] Dynamic subtest scatterlist: SUCCESS (1.726s)
[515.836608] Starting dynamic subtest: syncmap
[519.095528] Dynamic subtest syncmap: SUCCESS (3.267s)
[519.105916] Starting dynamic subtest: uncore
[519.773770] Dynamic subtest uncore: SUCCESS (0.677s)
[519.783431] Starting dynamic subtest: ring
[520.609436] Dynamic subtest ring: SUCCESS (0.832s)
[520.621584] Starting dynamic subtest: engine
[521.343580] Dynamic subtest engine: SUCCESS (0.732s)
[521.352448] Starting dynamic subtest: timelines
[525.304284] Dynamic subtest timelines: SUCCESS (3.958s)
[525.314017] Starting dynamic subtest: requests
[528.644630] Dynamic subtest requests: SUCCESS (3.339s)
[528.655068] Starting dynamic subtest: objects
[529.539815] Dynamic subtest objects: SUCCESS (0.894s)
[529.548828] Starting dynamic subtest: phys
[530.399861] Dynamic subtest phys: SUCCESS (0.858s)
[530.408776] Starting dynamic subtest: dmabuf
[531.276831] Dynamic subtest dmabuf: SUCCESS (0.875s)
[531.286737] Starting dynamic subtest: vma
[536.734709] Dynamic subtest vma: SUCCESS (5.456s)
[536.744287] Starting dynamic subtest: evict
[538.146665] Dynamic subtest evict: SUCCESS (1.410s)
[538.156613] Starting dynamic subtest: gtt
[541.374048] Dynamic subtest gtt: SUCCESS (3.226s)
[541.384246] Starting dynamic subtest: hugepages
[542.266612] Dynamic subtest hugepages: SUCCESS (0.888s)
[542.275983] Starting dynamic subtest: memory_region
[544.900309] Dynamic subtest memory_region: SUCCESS (2.635s)
[544.903266] Subtest mock: SUCCESS (40.078s)
[544.935537] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[544.936213] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[544.939214] [131/133] (477s left) gem_mmap_gtt (basic-write-read)
[546.434746] Subtest basic-write-read: SKIP (0.000s)
[546.509937] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[546.511992] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[546.515665] [132/133] (475s left) perf (gen12-group-exclusive-stream-sample-oa)
[546.655127] Starting subtest: gen12-group-exclusive-stream-sample-oa
[546.678034] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[546.717099] [133/133] (475s left) perf_pmu (busy-double-start)
[546.758267] Starting subtest: busy-double-start
[546.760560] Starting dynamic subtest: rcs0
[550.408715] Dynamic subtest rcs0: FAIL (3.596s)
[550.419089] Starting dynamic subtest: bcs0
[553.928141] Dynamic subtest bcs0: SUCCESS (3.574s)
[553.939731] Starting dynamic subtest: vcs0
[558.502264] Dynamic subtest vcs0: SUCCESS (4.572s)
[558.513514] Starting dynamic subtest: vcs1
[562.431831] Dynamic subtest vcs1: SUCCESS (3.926s)
[562.442319] Starting dynamic subtest: vecs0
[566.466933] Dynamic subtest vecs0: SUCCESS (4.035s)
[566.477935] Starting dynamic subtest: ccs0
[570.101252] Dynamic subtest ccs0: FAIL (3.565s)
[570.103255] Subtest busy-double-start: FAIL (23.280s)
[570.165178] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_cdclk
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: core_getstats
results: parsing output: 30/ for test: kms_rmfb
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_prime
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_scaling_modes
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ringfill
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_cs_tlb
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_bad_reloc
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: perf_pmu
Done.