[147.934188] Initializing watchdogs
[147.934234]   /dev/watchdog0
[147.950472] [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]
[147.955392] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[147.957973] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[147.960990] [001/156] (960s left) gem_render_linear_blits (basic)
[148.026986] Starting subtest: basic
[148.070321] Subtest basic: SUCCESS (0.042s)
[148.144630] [002/156] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[148.201450] Starting subtest: stress-mm-invalidate-close-overlap
[150.394802] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[150.459178] [003/156] (958s left) gem_exec_params (sol-reset-invalid)
[150.506227] Starting subtest: sol-reset-invalid
[150.509015] Subtest sol-reset-invalid: SUCCESS (0.002s)
[152.391180] [004/156] (956s left) gem_exec_endless (dispatch)
[152.453257] Starting subtest: dispatch
[152.454543] Starting dynamic subtest: rcs0
[152.459187] Dynamic subtest rcs0: SUCCESS (0.005s)
[152.469662] Starting dynamic subtest: bcs0
[152.472302] Dynamic subtest bcs0: SUCCESS (0.005s)
[152.479611] Starting dynamic subtest: vcs0
[152.481343] Dynamic subtest vcs0: SUCCESS (0.004s)
[152.488676] Starting dynamic subtest: vcs1
[152.490351] Dynamic subtest vcs1: SUCCESS (0.004s)
[152.496905] Starting dynamic subtest: vecs0
[152.499812] Dynamic subtest vecs0: SUCCESS (0.006s)
[152.505670] Starting dynamic subtest: ccs0
[152.507322] Dynamic subtest ccs0: SUCCESS (0.008s)
[152.508261] Subtest dispatch: SUCCESS (0.034s)
[154.371826] [005/156] (954s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[154.467900] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[154.468967] Starting dynamic subtest: pipe-A-eDP-1
[154.472844] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.479427] Starting dynamic subtest: pipe-B-eDP-1
[154.483109] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.489364] Starting dynamic subtest: pipe-C-eDP-1
[154.493274] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.499703] Starting dynamic subtest: pipe-D-eDP-1
[154.503537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.505384] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[157.031625] [006/156] (951s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[157.087041] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[157.089161] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[157.262208] [007/156] (951s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[157.357711] Starting subtest: nonblocking-crc-frame-sequence
[157.358875] Starting dynamic subtest: pipe-A-eDP-1
[158.096823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[158.103533] Starting dynamic subtest: pipe-B-eDP-1
[159.543060] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[159.551409] Starting dynamic subtest: pipe-C-eDP-1
[160.942728] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[160.950841] Starting dynamic subtest: pipe-D-eDP-1
[162.365343] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s)
[162.366431] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.007s)
[163.174776] [008/156] (945s left) perf_pmu (most-busy-check-all)
[163.209349] Starting subtest: most-busy-check-all
[163.210251] Starting dynamic subtest: rcs0
[164.327947] Dynamic subtest rcs0: SUCCESS (1.108s)
[164.335899] Starting dynamic subtest: bcs0
[166.312986] Dynamic subtest bcs0: SUCCESS (1.983s)
[166.323610] Starting dynamic subtest: vcs0
[168.360226] Dynamic subtest vcs0: SUCCESS (2.045s)
[168.369521] Starting dynamic subtest: vcs1
[170.344072] Dynamic subtest vcs1: SUCCESS (1.982s)
[170.350694] Starting dynamic subtest: vecs0
[172.327314] Dynamic subtest vecs0: SUCCESS (1.982s)
[172.334033] Starting dynamic subtest: ccs0
[174.312082] Dynamic subtest ccs0: SUCCESS (1.983s)
[174.313404] Subtest most-busy-check-all: SUCCESS (11.092s)
[174.409968] [009/156] (934s left) sysfs_timeslice_duration (duration)
[174.455443] Starting subtest: duration
[174.456536] Starting dynamic subtest: vecs0
[189.319184] Dynamic subtest vecs0: SUCCESS (14.851s)
[189.328695] Starting dynamic subtest: ccs0
[202.463662] Dynamic subtest ccs0: SUCCESS (13.141s)
[202.470483] Starting dynamic subtest: vcs0
[216.262774] Dynamic subtest vcs0: SUCCESS (13.798s)
[216.270064] Starting dynamic subtest: bcs0
[229.402409] Dynamic subtest bcs0: SUCCESS (13.145s)
[229.413924] Starting dynamic subtest: rcs0
[242.544024] Dynamic subtest rcs0: SUCCESS (13.141s)
[242.554406] Starting dynamic subtest: vcs1
[256.261942] Dynamic subtest vcs1: SUCCESS (13.707s)
[256.263423] Subtest duration: SUCCESS (81.790s)
[256.321529] [010/156] (852s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[256.427800] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[256.429444] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[256.520925] [011/156] (852s left) kms_chamelium_color (ctm-green-to-red)
[256.608073] Subtest ctm-green-to-red: SKIP (0.000s)
[256.645117] [012/156] (852s left) kms_vblank (ts-continuation-dpms-rpm)
[256.738927] Starting subtest: ts-continuation-dpms-rpm
[256.739986] Starting dynamic subtest: pipe-A-eDP-1
[259.250947] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.511s)
[259.260386] Starting dynamic subtest: pipe-D-eDP-1
[261.497777] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[261.498842] Subtest ts-continuation-dpms-rpm: SUCCESS (4.758s)
[262.388278] [013/156] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[262.481599] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[262.483364] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[262.578882] [014/156] (846s left) kms_plane_scaling (planes-downscale-factor-0-75)
[262.668070] Starting subtest: planes-downscale-factor-0-75
[262.668947] Starting dynamic subtest: pipe-A
[262.687461] Dynamic subtest pipe-A: SKIP (0.019s)
[262.694589] Starting dynamic subtest: pipe-B
[262.720021] Dynamic subtest pipe-B: SKIP (0.032s)
[262.728822] Starting dynamic subtest: pipe-C
[262.751798] Dynamic subtest pipe-C: SKIP (0.032s)
[262.758524] Starting dynamic subtest: pipe-D
[262.785932] Dynamic subtest pipe-D: SKIP (0.033s)
[262.787690] Subtest planes-downscale-factor-0-75: SKIP (0.116s)
[262.876792] [015/156] (846s left) kms_draw_crc (draw-method-render)
[262.963536] Starting subtest: draw-method-render
[262.964502] Starting dynamic subtest: xrgb8888-untiled
[263.206769] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[263.214624] Starting dynamic subtest: rgb565-untiled
[263.462342] Dynamic subtest rgb565-untiled: SUCCESS (0.254s)
[263.469262] Starting dynamic subtest: xrgb2101010-untiled
[263.695512] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[263.707788] Starting dynamic subtest: xbgr16161616f-untiled
[263.929733] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[263.941783] Starting dynamic subtest: xrgb8888-xtiled
[264.073411] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[264.082158] Starting dynamic subtest: rgb565-xtiled
[264.184493] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[264.192538] Starting dynamic subtest: xrgb2101010-xtiled
[264.306955] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[264.317720] Starting dynamic subtest: xbgr16161616f-xtiled
[264.440282] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[264.448914] Starting dynamic subtest: xrgb8888-4tiled
[264.573701] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[264.582127] Starting dynamic subtest: rgb565-4tiled
[264.695552] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[264.706385] Starting dynamic subtest: xrgb2101010-4tiled
[264.829668] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[264.839881] Starting dynamic subtest: xbgr16161616f-4tiled
[264.962278] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[264.963282] Subtest draw-method-render: SUCCESS (2.000s)
[265.073038] [016/156] (843s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[265.160045] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[265.161867] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[265.275274] [017/156] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[265.369078] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[265.370834] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.443476] [018/156] (843s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[265.489368] Starting subtest: multi-wait-available-submitted-signaled
[265.490466] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[265.581696] [019/156] (843s left) sw_sync (sync_multi_producer_single_consumer)
[265.610624] Starting subtest: sync_multi_producer_single_consumer
[266.693235] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[266.753354] [020/156] (842s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[266.840403] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[266.842120] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[266.903961] [021/156] (842s left) gem_vm_create (invalid-create)
[266.956242] Starting subtest: invalid-create
[266.958347] Subtest invalid-create: SUCCESS (0.002s)
[267.057431] [022/156] (842s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[267.156335] Starting subtest: fbcpsrhdr-suspend
[267.157968] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[267.250319] [023/156] (841s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[267.342671] Starting subtest: 4-tiled-16bpp-rotate-270
[267.363343] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[267.474548] [024/156] (841s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[267.567354] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[267.569189] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[267.671505] [025/156] (841s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[267.790779] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[268.783915] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.992s)
[269.607149] [026/156] (839s left) gem_pxp (protected-raw-src-copy-not-readible)
[269.722624] Starting subtest: protected-raw-src-copy-not-readible
[269.782610] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[269.903968] [027/156] (839s left) kms_cursor_crc (cursor-offscreen-128x42)
[270.115563] Starting subtest: cursor-offscreen-128x42
[270.160471] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[270.352241] [028/156] (838s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[270.456545] Starting subtest: yf-tiled-64bpp-rotate-180
[270.458387] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[270.568609] [029/156] (838s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[270.664733] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[270.666485] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[270.727399] [030/156] (838s left) i915_suspend (debugfs-reader)
[270.776316] Starting subtest: debugfs-reader
[289.350844] Subtest debugfs-reader: SUCCESS (3.699s)
[297.494373] [031/156] (820s left) gem_mmap_wc (write-read-distinct)
[297.550242] Subtest write-read-distinct: SKIP (0.000s)
[297.607156] [032/156] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[297.711374] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[297.712985] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[297.801063] [033/156] (819s left) kms_properties (invalid-properties-legacy)
[297.880713] Starting subtest: invalid-properties-legacy
[297.989406] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[298.072485] [034/156] (819s left) kms_pm_rpm (pc8-residency)
[300.410159] Starting subtest: pc8-residency
[300.413085] Subtest pc8-residency: SKIP (0.000s)
[300.802862] [035/156] (816s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[300.900507] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[300.902570] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[300.986294] [036/156] (816s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[301.359809] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[302.210099] [037/156] (815s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[302.305246] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[303.065907] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.759s)
[303.245369] [038/156] (814s left) kms_addfb_basic (bad-pitch-999)
[303.298355] Starting subtest: bad-pitch-999
[303.299367] Subtest bad-pitch-999: SUCCESS (0.000s)
[303.429890] [039/156] (814s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[303.522785] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[303.524579] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[303.642566] [040/156] (814s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[303.693640] Subtest untiled-to-tiled: SKIP (0.000s)
[303.759679] [041/156] (814s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[303.868338] Starting subtest: flip-vs-cursor-toggle
[313.016180] Subtest flip-vs-cursor-toggle: SUCCESS (9.141s)
[313.874584] [042/156] (803s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[313.962946] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[313.964641] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[314.028258] [043/156] (803s left) kms_async_flips (async-flip-hang)
[314.111956] Starting subtest: async-flip-hang
[314.496285] Starting dynamic subtest: pipe-A-eDP-1
[329.695210] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.192s)
[330.067581] Starting dynamic subtest: pipe-B-eDP-1
[345.691182] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.629s)
[346.064955] Starting dynamic subtest: pipe-C-eDP-1
[361.749833] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.689s)
[362.147748] Starting dynamic subtest: pipe-D-eDP-1
[377.685600] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.538s)
[377.686706] Subtest async-flip-hang: SUCCESS (63.559s)
[378.859278] [044/156] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[378.952703] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[378.954500] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[379.055655] [045/156] (738s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[379.169223] Starting subtest: cursorA-vs-flipB-varying-size
[379.171053] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[379.306611] [046/156] (738s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[379.394768] Starting subtest: yf-tiled-16bpp-rotate-0
[379.396549] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[379.493617] [047/156] (738s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[379.585233] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[379.587113] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[379.663097] [048/156] (738s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[379.750731] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[379.752640] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[379.842444] [049/156] (738s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[379.942730] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[379.944414] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[380.039083] [050/156] (738s left) syncobj_timeline (multi-wait-all-signaled)
[380.089432] Starting subtest: multi-wait-all-signaled
[380.090708] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[380.195471] [051/156] (737s left) gem_ctx_persistence (heartbeat-many)
[380.247855] Starting subtest: heartbeat-many
[380.250193] Subtest heartbeat-many: SKIP (0.000s)
[380.342854] [052/156] (737s left) gen7_exec_parse (basic-rejected)
[380.393530] Subtest basic-rejected: SKIP (0.000s)
[380.449074] [053/156] (737s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[380.539505] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[380.541155] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[380.623651] [054/156] (737s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[380.713116] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[380.714046] Starting dynamic subtest: pipe-A-eDP-1
[380.723219] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[380.732113] Starting dynamic subtest: pipe-B-eDP-1
[380.741289] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[380.749562] Starting dynamic subtest: pipe-C-eDP-1
[380.757862] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[380.765722] Starting dynamic subtest: pipe-D-eDP-1
[380.775094] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[380.776727] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[383.012151] [055/156] (735s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[383.113749] Starting subtest: plane-all-modeset-transition-internal-panels
[383.114818] Starting dynamic subtest: pipe-A-eDP-1
[384.466725] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.343s)
[384.748809] Starting dynamic subtest: pipe-B-eDP-1
[385.799237] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[386.066161] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.951s)
[386.901927] [056/156] (731s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[386.995032] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[396.868691] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.864s)
[396.989775] [057/156] (721s left) gem_softpin (evict-prime)
[397.052833] Starting subtest: evict-prime
[397.053901] Starting dynamic subtest: rcs0
[398.211495] Dynamic subtest rcs0: SUCCESS (1.158s)
[398.225470] Starting dynamic subtest: bcs0
[399.364700] Dynamic subtest bcs0: SUCCESS (1.151s)
[399.377112] Starting dynamic subtest: vcs0
[401.160125] Dynamic subtest vcs0: SUCCESS (1.785s)
[401.172044] Starting dynamic subtest: vcs1
[403.144944] Dynamic subtest vcs1: SUCCESS (1.983s)
[403.154267] Starting dynamic subtest: vecs0
[405.195172] Dynamic subtest vecs0: SUCCESS (2.049s)
[405.206482] Starting dynamic subtest: ccs0
[406.322071] Dynamic subtest ccs0: SUCCESS (1.135s)
[406.332422] Starting dynamic subtest: all
[408.204587] Dynamic subtest all: SUCCESS (1.870s)
[408.206165] Subtest evict-prime: SUCCESS (11.144s)
[408.294481] [058/156] (710s left) gem_ctx_param (invalid-ctx-set)
[408.346199] Starting subtest: invalid-ctx-set
[408.347327] Subtest invalid-ctx-set: SUCCESS (0.001s)
[408.456013] [059/156] (709s left) kms_chamelium_frames (vga-frame-dump)
[408.835099] Subtest vga-frame-dump: SKIP (0.000s)
[409.648012] [060/156] (708s left) gem_exec_flush (basic-wb-ro-default)
[409.697904] Starting subtest: basic-wb-ro-default
[415.151203] Subtest basic-wb-ro-default: SUCCESS (5.454s)
[415.334806] [061/156] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[415.428287] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[415.429927] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[415.521992] [062/156] (702s left) kms_hdr (static-swap)
[415.618667] Starting subtest: static-swap
[415.619736] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[415.621716] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[415.631098] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[415.632934] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[415.634520] Subtest static-swap: SKIP (0.002s)
[415.684982] [063/156] (702s left) kms_plane_lowres (tiling-y)
[415.771235] Starting subtest: tiling-y
[415.772864] Subtest tiling-y: SKIP (0.000s)
[415.836073] [064/156] (702s left) kms_addfb_basic (invalid-get-prop)
[415.882076] Starting subtest: invalid-get-prop
[415.882990] Subtest invalid-get-prop: SUCCESS (0.000s)
[416.044570] [065/156] (702s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[416.134486] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[416.136108] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[416.212066] [066/156] (702s left) kms_content_protection (lic-type-0)
[416.357191] Starting subtest: lic-type-0
[416.359219] Subtest lic-type-0: SKIP (0.000s)
[416.487450] [067/156] (702s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[416.572202] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[416.573878] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[417.704300] [068/156] (700s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[417.793698] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[417.795473] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[417.872120] [069/156] (700s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[417.994633] Starting subtest: flip-vs-cursor-atomic
[425.576163] Subtest flip-vs-cursor-atomic: SUCCESS (7.580s)
[426.433892] [070/156] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[426.527645] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[426.529348] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[426.619164] [071/156] (692s left) gem_exec_balancer (hang)
[426.886884] Starting subtest: hang
[428.624936] Subtest hang: SUCCESS (1.749s)
[428.738598] [072/156] (690s left) kms_pm_dc (dc5-dpms-negative)
[429.835763] Starting subtest: dc5-dpms-negative
[429.837862] Subtest dc5-dpms-negative: SKIP (0.000s)
[429.903362] [073/156] (688s left) gem_huc_copy (huc-copy)
[429.966414] Starting subtest: huc-copy
[429.968822] Subtest huc-copy: SUCCESS (0.002s)
[430.082239] [074/156] (688s left) kms_selftest (drm_plane_helper)
[430.114353] Starting subtest: drm_plane_helper
[430.168885] Starting dynamic subtest: drm_test_check_plane_state
[430.273303] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.104s)
[430.281789] Starting dynamic subtest: drm_test_check_invalid_plane_state
[430.367781] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.093s)
[430.368939] Subtest drm_plane_helper: SUCCESS (0.255s)
[430.510821] [075/156] (688s left) gem_eio (create)
[430.750731] Starting subtest: create
[431.092466] Subtest create: SUCCESS (0.342s)
[431.206965] [076/156] (687s left) gem_exec_fence (syncobj-wait)
[431.636272] Starting subtest: syncobj-wait
[433.245317] Subtest syncobj-wait: SUCCESS (1.598s)
[435.230009] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[435.232474] [077/156] (683s left) gem_mmap_wc (write)
[435.283860] Subtest write: SKIP (0.000s)
[435.345984] [078/156] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[435.445267] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[445.030720] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.586s)
[445.161230] [079/156] (673s left) kms_psr (fbc-pr-primary-blt)
[445.245869] Starting subtest: fbc-pr-primary-blt
[445.247667] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[445.318441] [080/156] (673s left) api_intel_allocator (execbuf-with-allocator)
[445.364727] Starting subtest: execbuf-with-allocator
[445.369039] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[445.485344] [081/156] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[445.586594] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[445.588906] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.664221] [082/156] (673s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[445.763820] Starting subtest: x-tiled-16bpp-rotate-0
[447.143058] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.379s)
[447.252175] [083/156] (671s left) kms_lease (lessee-list)
[447.335781] Starting subtest: lessee-list
[447.336605] Starting dynamic subtest: pipe-A-eDP-1
[447.338545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[447.347473] Starting dynamic subtest: pipe-B-eDP-1
[447.348777] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[447.357375] Starting dynamic subtest: pipe-C-eDP-1
[447.358171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[447.366700] Starting dynamic subtest: pipe-D-eDP-1
[447.367560] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[447.368542] Subtest lessee-list: SUCCESS (0.009s)
[447.458041] [084/156] (671s left) kms_properties (plane-properties-legacy)
[447.539068] Starting subtest: plane-properties-legacy
[447.540030] Starting dynamic subtest: pipe-A-eDP-1
[448.079904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[448.089571] Starting dynamic subtest: pipe-B-eDP-1
[449.394729] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s)
[449.405198] Starting dynamic subtest: pipe-C-eDP-1
[450.716187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.320s)
[450.727408] Starting dynamic subtest: pipe-D-eDP-1
[451.955392] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[451.956470] Subtest plane-properties-legacy: SUCCESS (4.416s)
[452.774201] [085/156] (666s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[452.873129] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[452.875022] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[452.973029] [086/156] (666s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[453.061195] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[457.797966] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.738s)
[457.899066] [087/156] (661s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[457.988121] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[457.989754] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.075450] [088/156] (661s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[458.159277] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[458.160948] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[458.252574] [089/156] (661s left) kms_psr (fbc-psr2-cursor-blt)
[458.335063] Starting subtest: fbc-psr2-cursor-blt
[458.335994] Starting dynamic subtest: eDP-1
[458.337772] Dynamic subtest eDP-1: SKIP (0.000s)
[458.339435] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[458.407339] [090/156] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[458.504402] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[458.507243] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[458.590838] [091/156] (660s left) gen9_exec_parse (valid-registers)
[458.648712] Subtest valid-registers: SKIP (0.000s)
[458.718966] [092/156] (660s left) kms_psr (fbc-psr-basic)
[458.799966] Starting subtest: fbc-psr-basic
[458.800936] Starting dynamic subtest: eDP-1
[458.802691] Dynamic subtest eDP-1: SKIP (0.000s)
[458.804394] Subtest fbc-psr-basic: SKIP (0.001s)
[458.868166] [093/156] (660s left) gem_ppgtt (shrink-vs-evict-any)
[458.920149] Starting subtest: shrink-vs-evict-any
[465.280654] Subtest shrink-vs-evict-any: SUCCESS (6.313s)
[465.351501] [094/156] (654s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[465.630022] Starting subtest: cursor-rapid-movement-512x512
[465.631582] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[465.774866] [095/156] (653s left) perf_pmu (busy-double-start)
[465.808352] Starting subtest: busy-double-start
[465.809615] Starting dynamic subtest: rcs0
[469.417424] Dynamic subtest rcs0: FAIL (3.587s)
[469.427476] Starting dynamic subtest: bcs0
[472.989050] Dynamic subtest bcs0: SUCCESS (3.592s)
[473.000946] Starting dynamic subtest: vcs0
[476.754154] Dynamic subtest vcs0: SUCCESS (3.762s)
[476.768020] Starting dynamic subtest: vcs1
[480.720271] Dynamic subtest vcs1: SUCCESS (3.963s)
[480.735104] Starting dynamic subtest: vecs0
[484.755996] Dynamic subtest vecs0: SUCCESS (4.033s)
[484.769138] Starting dynamic subtest: ccs0
[488.356757] Dynamic subtest ccs0: FAIL (3.569s)
[488.357561] Subtest busy-double-start: FAIL (22.516s)
[488.441712] [096/156] (631s left) kms_psr (pr-primary-page-flip)
[488.534337] Starting subtest: pr-primary-page-flip
[488.536016] Subtest pr-primary-page-flip: SKIP (0.000s)
[488.627499] [097/156] (631s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[488.726156] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[488.727876] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.838745] [098/156] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[488.921465] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[488.923349] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[489.006986] [099/156] (630s left) prime_udl
[489.079547] [100/156] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[489.165441] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[489.167383] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[489.266639] [101/156] (630s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[489.352968] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[489.354740] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[489.450429] [102/156] (630s left) gem_mmap_wc (write-cpu-read-wc)
[489.492195] Subtest write-cpu-read-wc: SKIP (0.000s)
[489.555140] [103/156] (630s left) i915_pm_rps (thresholds)
[489.599376] Starting subtest: thresholds
[489.601534] Subtest thresholds: SKIP (0.001s)
[489.695393] [104/156] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[489.779219] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[489.780890] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[489.873353] [105/156] (630s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[489.974188] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[489.976032] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[490.075863] [106/156] (629s left) syncobj_timeline (wait-for-submit-delayed-submit)
[490.131574] Starting subtest: wait-for-submit-delayed-submit
[490.235103] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[490.308810] [107/156] (629s left) gem_userptr_blits (coherency-sync)
[490.368207] Starting subtest: coherency-sync
[490.662583] Subtest coherency-sync: SKIP (0.273s)
[490.775090] [108/156] (629s left) prime_mmap (test_forked)
[490.863289] Starting subtest: test_forked
[490.864337] Starting dynamic subtest: test_forked-smem
[490.902314] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[490.903654] Subtest test_forked: SUCCESS (0.041s)
[491.000127] [109/156] (629s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[491.108682] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[491.110734] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[491.214586] [110/156] (628s left) core_setmaster (master-drop-set-user)
[491.302749] Starting subtest: master-drop-set-user
[491.313884] Subtest master-drop-set-user: SUCCESS (0.013s)
[491.347551] [111/156] (628s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[491.392063] Starting subtest: framebuffer-vs-set-tiling
[491.393925] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[491.519423] [112/156] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[491.604082] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[491.605849] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[491.697028] [113/156] (628s left) kms_flip (busy-flip)
[491.786450] Starting subtest: busy-flip
[491.788835] Starting dynamic subtest: A-eDP1
[493.514579] Dynamic subtest A-eDP1: SUCCESS (1.726s)
[493.525343] Starting dynamic subtest: B-eDP1
[495.247696] Dynamic subtest B-eDP1: SUCCESS (1.731s)
[495.260971] Starting dynamic subtest: C-eDP1
[496.974443] Dynamic subtest C-eDP1: SUCCESS (1.723s)
[496.986494] Starting dynamic subtest: D-eDP1
[498.713200] Dynamic subtest D-eDP1: SUCCESS (1.736s)
[498.715578] Subtest busy-flip: SUCCESS (6.928s)
[499.869324] [114/156] (620s left) syncobj_timeline (host-signal-points)
[499.922411] Starting subtest: host-signal-points
[499.926457] Subtest host-signal-points: SUCCESS (0.004s)
[499.995700] [115/156] (620s left) prime_busy (after)
[500.040214] Starting subtest: after
[500.042823] Starting dynamic subtest: rcs0
[500.067800] Dynamic subtest rcs0: SUCCESS (0.025s)
[500.078880] Starting dynamic subtest: bcs0
[500.109364] Dynamic subtest bcs0: SUCCESS (0.041s)
[500.118984] Starting dynamic subtest: vcs0
[500.150429] Dynamic subtest vcs0: SUCCESS (0.040s)
[500.159668] Starting dynamic subtest: vcs1
[500.192237] Dynamic subtest vcs1: SUCCESS (0.041s)
[500.201726] Starting dynamic subtest: vecs0
[500.233269] Dynamic subtest vecs0: SUCCESS (0.041s)
[500.242772] Starting dynamic subtest: ccs0
[500.275338] Dynamic subtest ccs0: SUCCESS (0.041s)
[500.380722] Subtest after: SUCCESS (0.340s)
[500.465459] [116/156] (619s left) gem_exec_schedule (pi-distinct-iova)
[500.642616] Starting subtest: pi-distinct-iova
[500.643963] Starting dynamic subtest: rcs0
[500.727578] Dynamic subtest rcs0: SUCCESS (0.085s)
[500.740401] Starting dynamic subtest: vcs0
[500.789023] Dynamic subtest vcs0: SUCCESS (0.061s)
[500.802667] Starting dynamic subtest: vcs1
[500.852662] Dynamic subtest vcs1: SUCCESS (0.063s)
[500.864996] Starting dynamic subtest: vecs0
[500.909702] Dynamic subtest vecs0: SUCCESS (0.056s)
[500.922665] Starting dynamic subtest: ccs0
[500.981561] Dynamic subtest ccs0: SUCCESS (0.071s)
[500.983065] Subtest pi-distinct-iova: SUCCESS (0.340s)
[502.304614] [117/156] (618s left) kms_psr (psr2-primary-mmap-cpu)
[502.397076] Starting subtest: psr2-primary-mmap-cpu
[502.398032] Starting dynamic subtest: eDP-1
[504.178045] Dynamic subtest eDP-1: SUCCESS (1.780s)
[504.178948] Subtest psr2-primary-mmap-cpu: SUCCESS (1.782s)
[505.043569] [118/156] (615s left) gem_exec_flush (basic-wb-pro-default)
[505.119547] Starting subtest: basic-wb-pro-default
[510.581419] Subtest basic-wb-pro-default: SUCCESS (5.460s)
[510.776598] [119/156] (609s left) fbdev (info)
[510.809062] Starting subtest: info
[510.809974] Subtest info: SUCCESS (0.000s)
[510.872699] [120/156] (609s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[510.962395] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[510.964391] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[511.065791] [121/156] (609s left) gem_softpin (softpin)
[511.128504] Starting subtest: softpin
[543.451058] Subtest softpin: SUCCESS (32.320s)
[543.569739] [122/156] (577s left) i915_module_load (reload)
[543.601661] Starting subtest: reload
[549.938859] Subtest reload: SUCCESS (6.338s)
[549.976517] [123/156] (570s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[551.180791] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[551.182347] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[551.285536] [124/156] (569s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[551.393785] Starting subtest: 4-tiled-32bpp-rotate-270
[551.426962] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.033s)
[551.544707] [125/156] (569s left) gem_ctx_isolation (clean)
[551.600276] Starting subtest: clean
[551.601285] Starting dynamic subtest: rcs0
[551.663965] Dynamic subtest rcs0: SUCCESS (0.063s)
[551.674728] Starting dynamic subtest: bcs0
[551.729149] Dynamic subtest bcs0: SUCCESS (0.064s)
[551.737923] Starting dynamic subtest: vcs0
[551.785455] Dynamic subtest vcs0: SUCCESS (0.055s)
[551.795527] Starting dynamic subtest: vcs1
[553.216112] Dynamic subtest vcs1: SUCCESS (1.430s)
[553.226574] Starting dynamic subtest: vecs0
[555.196852] Dynamic subtest vecs0: SUCCESS (1.979s)
[555.205290] Starting dynamic subtest: ccs0
[557.203883] Dynamic subtest ccs0: SUCCESS (2.006s)
[557.204887] Subtest clean: SUCCESS (5.604s)
[557.426825] [126/156] (563s left) kms_invalid_mode (int-max-clock)
[557.517860] Starting subtest: int-max-clock
[557.518776] Starting dynamic subtest: pipe-A-eDP-1
[557.803736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[557.813890] Starting dynamic subtest: pipe-B-eDP-1
[557.814866] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[557.822693] Starting dynamic subtest: pipe-C-eDP-1
[557.823708] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[557.831868] Starting dynamic subtest: pipe-D-eDP-1
[557.832942] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[557.833895] Subtest int-max-clock: SUCCESS (0.292s)
[558.615342] [127/156] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[558.667279] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[558.774906] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[558.857842] [128/156] (561s left) gem_create (create-ext-placement-each)
[559.024036] Starting subtest: create-ext-placement-each
[559.025306] Subtest create-ext-placement-each: SUCCESS (0.000s)
[559.124648] [129/156] (561s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[559.223916] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[559.224742] Starting dynamic subtest: pipe-A
[559.289943] Dynamic subtest pipe-A: SUCCESS (0.066s)
[559.300840] Starting dynamic subtest: pipe-B
[560.449697] Dynamic subtest pipe-B: SUCCESS (1.158s)
[560.460487] Starting dynamic subtest: pipe-C
[561.561655] Dynamic subtest pipe-C: SUCCESS (1.110s)
[561.569956] Starting dynamic subtest: pipe-D
[562.701252] Dynamic subtest pipe-D: SUCCESS (1.139s)
[562.702197] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.478s)
[563.856317] [130/156] (557s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[563.947137] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[563.958569] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[564.045329] [131/156] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[564.133265] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[570.969445] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.836s)
[571.111511] [132/156] (549s left) gem_fence_thrash (bo-copy)
[571.148367] Starting subtest: bo-copy
[571.162001] Subtest bo-copy: SKIP (0.013s)
[571.227812] [133/156] (549s left) gem_userptr_blits (access-control)
[571.296045] Starting subtest: access-control
[571.298117] Subtest access-control: SKIP (0.000s)
[571.419862] [134/156] (549s left) kms_flip (2x-flip-vs-suspend)
[571.504116] Starting subtest: 2x-flip-vs-suspend
[571.508409] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[571.600709] [135/156] (549s left) drm_read (empty-nonblock)
[571.740482] Starting subtest: empty-nonblock
[571.741804] Subtest empty-nonblock: SUCCESS (0.000s)
[571.862376] [136/156] (549s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[571.971534] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[604.043395] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.069s)
[604.912715] [137/156] (516s left) kms_cursor_legacy (single-bo)
[605.027896] Starting subtest: single-bo
[605.028891] Starting dynamic subtest: pipe-A
[610.454209] Dynamic subtest pipe-A: SUCCESS (5.379s)
[610.464716] Starting dynamic subtest: pipe-B
[615.836500] Dynamic subtest pipe-B: SUCCESS (5.379s)
[615.847997] Starting dynamic subtest: pipe-C
[621.218740] Dynamic subtest pipe-C: SUCCESS (5.379s)
[621.229745] Starting dynamic subtest: pipe-D
[626.600700] Dynamic subtest pipe-D: SUCCESS (5.379s)
[626.610882] Starting dynamic subtest: all-pipes
[631.952965] Dynamic subtest all-pipes: SUCCESS (5.386s)
[631.953943] Subtest single-bo: SUCCESS (26.915s)
[632.086650] [138/156] (489s left) kms_color (legacy-gamma)
[632.171089] Starting subtest: legacy-gamma
[632.172101] Starting dynamic subtest: pipe-A-eDP-1
[632.896703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[632.906259] Starting dynamic subtest: pipe-B-eDP-1
[634.339670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[634.348300] Starting dynamic subtest: pipe-C-eDP-1
[635.719165] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[635.731549] Starting dynamic subtest: pipe-D-eDP-1
[637.119466] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[637.120472] Subtest legacy-gamma: SUCCESS (4.949s)
[637.933955] [139/156] (483s left) api_intel_bb (destroy-bb)
[637.985297] Starting subtest: destroy-bb
[637.992656] Subtest destroy-bb: SUCCESS (0.008s)
[638.111140] [140/156] (483s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[638.212811] Starting subtest: pr-cursor-plane-move-continuous-sf
[638.214562] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[638.280611] [141/156] (482s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[638.369040] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[638.370842] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[638.455622] [142/156] (482s left) gem_exec_store (pages)
[638.514938] Starting subtest: pages
[638.515968] Starting dynamic subtest: rcs0
[638.611611] Dynamic subtest rcs0: SUCCESS (0.096s)
[638.623128] Starting dynamic subtest: bcs0
[638.689129] Dynamic subtest bcs0: SUCCESS (0.076s)
[638.700614] Starting dynamic subtest: vcs0
[638.779169] Dynamic subtest vcs0: SUCCESS (0.089s)
[638.791523] Starting dynamic subtest: vcs1
[638.855560] Dynamic subtest vcs1: SUCCESS (0.074s)
[638.866344] Starting dynamic subtest: vecs0
[638.924465] Dynamic subtest vecs0: SUCCESS (0.069s)
[638.933262] Starting dynamic subtest: ccs0
[639.003146] Dynamic subtest ccs0: SUCCESS (0.077s)
[639.004366] Subtest pages: SUCCESS (0.488s)
[639.196888] [143/156] (482s left) gem_exec_schedule (semaphore-power)
[639.380923] Subtest semaphore-power: SKIP (0.000s)
[639.548696] [144/156] (481s left) prime_vgem (basic-fence-flip)
[639.615350] Starting subtest: basic-fence-flip
[639.913480] Subtest basic-fence-flip: SUCCESS (0.298s)
[640.014853] [145/156] (481s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[640.098557] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[640.100496] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[640.213026] [146/156] (481s left) gem_mmap_offset (bad-extensions)
[640.258294] Starting subtest: bad-extensions
[640.259370] Subtest bad-extensions: SUCCESS (0.000s)
[640.357612] [147/156] (481s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[640.444198] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[640.445859] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[640.531054] [148/156] (480s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[640.628781] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[645.250486] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.621s)
[646.456382] [149/156] (475s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[646.553218] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[653.954105] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.403s)
[654.084652] [150/156] (467s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[654.192202] Starting subtest: cursor-tearing-framebuffer-change
[654.193214] Starting dynamic subtest: pipe-A-eDP-1
[654.773814] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[654.782907] Starting dynamic subtest: pipe-D-eDP-1
[656.016222] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[656.017027] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.824s)
[656.853452] [151/156] (464s left) perf (invalid-remove-userspace-config)
[656.990010] Starting subtest: invalid-remove-userspace-config
[656.997252] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[657.038071] [152/156] (464s left) kms_psr (psr-sprite-blt)
[657.128190] Starting subtest: psr-sprite-blt
[657.129146] Starting dynamic subtest: eDP-1
[658.867133] Dynamic subtest eDP-1: SUCCESS (1.738s)
[658.868137] Subtest psr-sprite-blt: SUCCESS (1.739s)
[659.721612] [153/156] (461s left) gem_exec_fence (submit-chain)
[659.902352] Starting subtest: submit-chain
[659.917021] Subtest submit-chain: SUCCESS (0.021s)
[661.259688] [154/156] (460s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[661.349563] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[661.352383] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[661.445195] [155/156] (460s left) gem_lmem_swapping (random-engines)
[661.487736] Subtest random-engines: SKIP (0.000s)
[661.531230] [156/156] (460s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[661.627457] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[661.628459] Starting dynamic subtest: pipe-A-eDP-1
[661.637231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[661.646731] Starting dynamic subtest: pipe-B-eDP-1
[661.655568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[661.664641] Starting dynamic subtest: pipe-C-eDP-1
[661.672800] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[661.681544] Starting dynamic subtest: pipe-D-eDP-1
[661.690012] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[661.691741] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[663.884392] Closing watchdogs
results: parsing output: 0/ for test: gem_render_linear_blits
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_exec_endless
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: sysfs_timeslice_duration
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_set_tiling_vs_blt
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gen7_exec_parse
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_hdr
results: parsing output: 62/ for test: kms_plane_lowres
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: gem_huc_copy
results: parsing output: 73/ for test: kms_selftest
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_ppgtt
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: prime_udl
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_wc
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: core_setmaster
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: prime_busy
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: i915_module_load
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_fence_thrash
results: parsing output: 132/ for test: gem_userptr_blits
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: drm_read
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_color
results: parsing output: 138/ for test: api_intel_bb
results: parsing output: 139/ for test: kms_psr2_sf
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: gem_exec_store
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: prime_vgem
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_mmap_offset
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_lmem_swapping
results: parsing output: 155/ for test: kms_ccs
Done.