[56.432745] Initializing watchdogs
[56.432849]   /dev/watchdog0
[56.449492] [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.454138] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.456437] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.459954] [001/156] (960s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[56.590745] Starting subtest: fbc-psr-sprite-mmap-gtt
[56.593079] Starting dynamic subtest: eDP-1
[56.597316] Dynamic subtest eDP-1: SKIP (0.000s)
[56.601918] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[56.674979] [002/156] (960s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[56.769257] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[56.773258] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[56.833251] [003/156] (960s left) gem_exec_nop (basic-parallel)
[56.919348] Starting subtest: basic-parallel
[72.318264] Subtest basic-parallel: SUCCESS (15.322s)
[72.752853] [004/156] (944s left) vgem_basic (debugfs)
[72.852195] Starting subtest: debugfs
[72.854171] Subtest debugfs: SUCCESS (0.000s)
[72.953034] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[72.956374] [005/156] (944s left) gem_exec_balancer (full-late)
[73.083655] Starting subtest: full-late
[78.207805] Subtest full-late: SUCCESS (5.118s)
[78.554919] [006/156] (938s left) kms_getfb (getfb-handle-zero)
[78.655629] Starting subtest: getfb-handle-zero
[78.658039] Subtest getfb-handle-zero: SUCCESS (0.000s)
[78.770056] [007/156] (938s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[78.866429] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[78.870508] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[78.971079] [008/156] (938s left) i915_pm_rps (thresholds-idle-park)
[79.026582] Starting subtest: thresholds-idle-park
[79.031090] Subtest thresholds-idle-park: SKIP (0.001s)
[79.142630] [009/156] (938s left) gem_userptr_blits (dmabuf-sync)
[79.215625] Starting subtest: dmabuf-sync
[79.220225] Subtest dmabuf-sync: SKIP (0.003s)
[79.358961] [010/156] (938s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[79.467439] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[79.470946] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[79.581273] [011/156] (937s left) gem_exec_params (invalid-bsd2-flag-on-render)
[79.637130] Starting subtest: invalid-bsd2-flag-on-render
[79.639071] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[79.732672] [012/156] (937s left) gem_lmem_swapping (verify)
[79.776158] Subtest verify: SKIP (0.000s)
[79.819106] [013/156] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[79.929612] Starting subtest: psr-2p-primscrn-cur-indfb-move
[79.933022] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[80.019678] [014/156] (937s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[80.117591] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[80.120966] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[80.204960] [015/156] (937s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[80.300947] Starting subtest: fbc-pr-cursor-plane-update-sf
[80.304552] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[80.367239] [016/156] (937s left) kms_atomic (atomic-plane-damage)
[80.459093] Starting subtest: atomic-plane-damage
[80.543981] Starting dynamic subtest: pipe-A-eDP-1
[81.116902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[81.119425] Subtest atomic-plane-damage: SUCCESS (0.659s)
[81.966309] [017/156] (935s left) gem_flink_race (flink_name)
[82.006524] Starting subtest: flink_name
[87.410696] Subtest flink_name: SUCCESS (5.393s)
[87.533136] [018/156] (930s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[87.648764] Starting subtest: x-tiled-64bpp-rotate-180
[89.276395] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.627s)
[89.455235] [019/156] (928s left) gen9_exec_parse (basic-rejected-ctx-param)
[89.518615] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[89.578561] [020/156] (928s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[89.675765] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[89.679107] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[89.774151] [021/156] (928s left) perf_pmu (pmu-read)
[89.815066] Starting subtest: pmu-read
[89.817107] Subtest pmu-read: SUCCESS (0.003s)
[89.924334] [022/156] (927s left) kms_psr (psr2-suspend)
[90.012187] Starting subtest: psr2-suspend
[90.014104] Starting dynamic subtest: eDP-1
[107.399268] Dynamic subtest eDP-1: SUCCESS (2.991s)
[107.401279] Subtest psr2-suspend: SUCCESS (2.991s)
[108.309272] [023/156] (909s left) sw_sync (sync_merge_same)
[108.358930] Starting subtest: sync_merge_same
[108.361063] Subtest sync_merge_same: SUCCESS (0.000s)
[108.419407] [024/156] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[108.525827] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[108.529935] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[108.613746] [025/156] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[108.723780] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[112.505654] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.719s)
[113.712218] [026/156] (904s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[113.765768] Starting subtest: etime-multi-wait-for-submit-submitted
[113.874887] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[113.961658] [027/156] (904s left) gem_render_copy (yf-tiled)
[114.021648] Starting subtest: yf-tiled
[114.026775] Subtest yf-tiled: SKIP (0.000s)
[114.213081] [028/156] (903s left) kms_addfb_basic (addfb25-bad-modifier)
[114.307729] Starting subtest: addfb25-bad-modifier
[114.310108] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[114.399763] [029/156] (903s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[114.497627] Starting subtest: hdr-rgb101010-draw-render
[114.502165] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[114.589916] [030/156] (903s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[114.684032] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[114.686380] Starting dynamic subtest: pipe-A
[114.710078] Dynamic subtest pipe-A: SKIP (0.021s)
[114.720452] Starting dynamic subtest: pipe-B
[114.749707] Dynamic subtest pipe-B: SKIP (0.038s)
[114.759158] Starting dynamic subtest: pipe-C
[114.789559] Dynamic subtest pipe-C: SKIP (0.039s)
[114.798978] Starting dynamic subtest: pipe-D
[114.829309] Dynamic subtest pipe-D: SKIP (0.038s)
[114.832947] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.138s)
[114.928212] [031/156] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[115.028062] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[116.178310] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.141s)
[116.313345] [032/156] (901s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[116.375191] Starting subtest: y-tiled-ccs-to-x-tiled
[116.378975] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[116.574862] [033/156] (901s left) sysfs_heartbeat_interval (mixed)
[116.634211] Starting subtest: mixed
[116.636640] Starting dynamic subtest: vecs0
[121.881393] Dynamic subtest vecs0: SUCCESS (5.214s)
[121.892241] Starting dynamic subtest: ccs0
[127.101236] Dynamic subtest ccs0: SUCCESS (5.201s)
[127.111293] Starting dynamic subtest: vcs0
[132.334784] Dynamic subtest vcs0: SUCCESS (5.221s)
[132.348361] Starting dynamic subtest: bcs0
[137.535892] Dynamic subtest bcs0: SUCCESS (5.195s)
[137.548945] Starting dynamic subtest: rcs0
[142.717920] Dynamic subtest rcs0: SUCCESS (5.182s)
[142.730541] Starting dynamic subtest: vcs1
[147.936131] Dynamic subtest vcs1: SUCCESS (5.216s)
[147.938876] Subtest mixed: SUCCESS (31.236s)
[148.014160] [034/156] (870s left) kms_chamelium_edid (vga-edid-read)
[148.410103] Subtest vga-edid-read: SKIP (0.000s)
[149.214621] [035/156] (869s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[149.323156] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[149.327370] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[149.428559] [036/156] (869s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[149.514092] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[149.516503] Starting dynamic subtest: pipe-A-eDP-1
[149.539717] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.551401] Starting dynamic subtest: pipe-B-eDP-1
[149.573048] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.582421] Starting dynamic subtest: pipe-C-eDP-1
[149.604119] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.613343] Starting dynamic subtest: pipe-D-eDP-1
[149.634517] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.638569] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[151.798768] [037/156] (866s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[151.892448] Starting subtest: fbc-psr2-sprite-mmap-cpu
[151.894676] Starting dynamic subtest: eDP-1
[151.898689] Dynamic subtest eDP-1: SKIP (0.000s)
[151.902802] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[151.976734] [038/156] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[152.083141] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[152.087538] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[152.174182] [039/156] (866s left) kms_chamelium_audio (hdmi-audio)
[152.569512] Subtest hdmi-audio: SKIP (0.000s)
[153.400959] [040/156] (865s left) gem_create (busy-create)
[153.457523] Starting subtest: busy-create
[153.459902] Starting dynamic subtest: smem0
[186.675452] Dynamic subtest smem0: SUCCESS (33.205s)
[186.677959] Subtest busy-create: SUCCESS (33.206s)
[186.889205] [041/156] (831s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[187.023042] Starting subtest: cursor-vs-flip-atomic
[216.802871] Subtest cursor-vs-flip-atomic: SUCCESS (29.778s)
[217.649101] [042/156] (801s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[217.745071] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[217.749287] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[217.852342] [043/156] (800s left) syncobj_timeline (wait-all-snapshot)
[217.910953] Starting subtest: wait-all-snapshot
[217.992065] Subtest wait-all-snapshot: SUCCESS (0.082s)
[218.076484] [044/156] (800s left) gem_eio (context-create)
[218.297677] Starting subtest: context-create
[218.627961] Subtest context-create: SUCCESS (0.332s)
[218.789953] [045/156] (800s left) i915_pm_rps (fence-order)
[218.852970] Starting subtest: fence-order
[221.913229] Subtest fence-order: SUCCESS (3.058s)
[222.025598] [046/156] (796s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[222.115730] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[222.118158] Starting dynamic subtest: pipe-A-default-mode
[224.901620] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[224.904288] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.788s)
[225.750742] [047/156] (793s left) gem_mmap_offset (open-flood)
[225.802191] Starting subtest: open-flood
[247.291428] Subtest open-flood: SUCCESS (21.491s)
[247.415947] [048/156] (771s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[247.525091] Starting subtest: bad-aux-stride-y-tiled-ccs
[247.527045] Starting dynamic subtest: pipe-A-eDP-1
[247.546355] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.557672] Starting dynamic subtest: pipe-B-eDP-1
[247.575729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.585144] Starting dynamic subtest: pipe-C-eDP-1
[247.604106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.614194] Starting dynamic subtest: pipe-D-eDP-1
[247.632478] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.635809] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[250.014907] [049/156] (769s left) kms_invalid_mode (int-max-clock)
[250.108883] Starting subtest: int-max-clock
[250.111152] Starting dynamic subtest: pipe-A-eDP-1
[250.396670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[250.407617] Starting dynamic subtest: pipe-B-eDP-1
[250.409901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[250.420100] Starting dynamic subtest: pipe-C-eDP-1
[250.422637] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[250.432552] Starting dynamic subtest: pipe-D-eDP-1
[250.434737] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.436912] Subtest int-max-clock: SUCCESS (0.297s)
[251.250104] [050/156] (767s left) kms_dsc (dsc-basic)
[251.348585] Starting subtest: dsc-basic
[251.361496] Subtest dsc-basic: SKIP (0.000s)
[251.422196] [051/156] (767s left) i915_hangman (gt-engine-hang)
[251.490666] Starting subtest: gt-engine-hang
[251.492908] Starting dynamic subtest: rcs0
[252.629734] Dynamic subtest rcs0: SUCCESS (1.138s)
[252.642620] Starting dynamic subtest: bcs0
[254.677209] Dynamic subtest bcs0: SUCCESS (2.045s)
[254.689545] Starting dynamic subtest: vcs0
[256.660238] Dynamic subtest vcs0: SUCCESS (1.981s)
[256.674738] Starting dynamic subtest: vcs1
[258.645393] Dynamic subtest vcs1: SUCCESS (1.982s)
[258.658932] Starting dynamic subtest: vecs0
[260.631147] Dynamic subtest vecs0: SUCCESS (1.983s)
[260.643979] Starting dynamic subtest: ccs0
[262.677265] Dynamic subtest ccs0: SUCCESS (2.043s)
[262.679829] Subtest gt-engine-hang: SUCCESS (11.186s)
[262.822589] [052/156] (756s left) gem_ctx_create (basic-files)
[262.875979] Starting subtest: basic-files
[265.262833] Subtest basic-files: SUCCESS (2.385s)
[266.727100] [053/156] (752s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[266.828892] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[266.833032] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[266.899191] [054/156] (752s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[266.960159] Starting subtest: y-tiled-to-vebox-x-tiled
[266.964748] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[267.172130] [055/156] (752s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[267.231116] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[267.233611] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[267.334205] [056/156] (752s left) kms_color (ctm-blue-to-red)
[267.440945] Starting subtest: ctm-blue-to-red
[267.443215] Starting dynamic subtest: pipe-A-eDP-1
[268.158716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[268.171124] Starting dynamic subtest: pipe-B-eDP-1
[269.548733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[269.559670] Starting dynamic subtest: pipe-C-eDP-1
[270.945929] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[270.956576] Starting dynamic subtest: pipe-D-eDP-1
[272.363869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s)
[272.366543] Subtest ctm-blue-to-red: SUCCESS (4.924s)
[273.174411] [057/156] (746s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[273.273554] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[273.278094] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[273.359726] [058/156] (746s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[273.464672] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[273.469104] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[273.544302] [059/156] (745s left) gem_render_copy (linear)
[273.603565] Starting subtest: linear
[273.605725] Starting dynamic subtest: smem
[273.642893] Dynamic subtest smem: SUCCESS (0.041s)
[273.645168] Subtest linear: SUCCESS (0.042s)
[273.880260] [060/156] (745s left) gem_lmem_swapping (parallel-multi)
[273.918638] Subtest parallel-multi: SKIP (0.000s)
[273.961576] [061/156] (745s left) kms_cursor_crc (cursor-onscreen-512x170)
[274.237798] Starting subtest: cursor-onscreen-512x170
[274.242353] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[274.379828] [062/156] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[274.478556] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[274.482522] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[274.595974] [063/156] (745s left) kms_addfb_basic (legacy-format)
[274.648633] Starting subtest: legacy-format
[274.676698] Subtest legacy-format: SUCCESS (0.025s)
[274.815391] [064/156] (744s left) gem_ctx_param (invalid-get-ringsize)
[274.873912] Starting subtest: invalid-get-ringsize
[274.875983] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[275.022074] [065/156] (744s left) kms_psr (pr-dpms)
[275.116296] Starting subtest: pr-dpms
[275.119426] Subtest pr-dpms: SKIP (0.000s)
[275.195186] [066/156] (744s left) gem_exec_reloc (basic-cpu-noreloc)
[275.259266] Subtest basic-cpu-noreloc: SKIP (0.000s)
[275.352866] [067/156] (744s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[275.454701] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[275.458286] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[275.540692] [068/156] (744s left) kms_plane_scaling (2x-scaler-multi-pipe)
[275.634987] Starting subtest: 2x-scaler-multi-pipe
[275.638791] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[275.742833] [069/156] (744s left) gem_create (create-invalid-size)
[275.797365] Starting subtest: create-invalid-size
[275.799335] Subtest create-invalid-size: SUCCESS (0.000s)
[275.978667] [070/156] (743s left) kms_plane_cursor (viewport)
[276.071612] Starting subtest: viewport
[276.076206] Starting dynamic subtest: pipe-A-eDP-1-size-64
[278.756402] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.685s)
[278.819748] Starting dynamic subtest: pipe-A-eDP-1-size-128
[281.525154] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.716s)
[281.586125] Starting dynamic subtest: pipe-A-eDP-1-size-256
[284.271211] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.694s)
[284.631887] Starting dynamic subtest: pipe-B-eDP-1-size-64
[288.080466] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.459s)
[288.140429] Starting dynamic subtest: pipe-B-eDP-1-size-128
[290.837587] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.705s)
[290.899713] Starting dynamic subtest: pipe-B-eDP-1-size-256
[293.583853] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.693s)
[293.945240] Starting dynamic subtest: pipe-C-eDP-1-size-64
[296.997181] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.064s)
[297.036895] Starting dynamic subtest: pipe-C-eDP-1-size-128
[299.398226] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.369s)
[299.437930] Starting dynamic subtest: pipe-C-eDP-1-size-256
[301.788993] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.359s)
[302.118787] Starting dynamic subtest: pipe-D-eDP-1-size-64
[305.234511] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.128s)
[305.276140] Starting dynamic subtest: pipe-D-eDP-1-size-128
[307.624240] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.359s)
[307.663083] Starting dynamic subtest: pipe-D-eDP-1-size-256
[310.014221] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.359s)
[310.332807] Subtest viewport: SUCCESS (34.251s)
[311.216519] [071/156] (708s left) kms_flip (wf_vblank-ts-check)
[311.311679] Starting subtest: wf_vblank-ts-check
[311.313939] Starting dynamic subtest: A-eDP1
[320.262402] Dynamic subtest A-eDP1: SUCCESS (8.950s)
[320.273700] Starting dynamic subtest: B-eDP1
[329.196234] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[329.206443] Starting dynamic subtest: C-eDP1
[338.119161] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[338.142580] Starting dynamic subtest: D-eDP1
[347.058296] Dynamic subtest D-eDP1: SUCCESS (8.939s)
[347.060288] Subtest wf_vblank-ts-check: SUCCESS (35.752s)
[348.286974] [072/156] (671s left) i915_drm_fdinfo (busy-idle)
[348.333198] Starting subtest: busy-idle
[348.335492] Starting dynamic subtest: rcs0
[348.361017] Dynamic subtest rcs0: SKIP (0.027s)
[348.372609] Starting dynamic subtest: bcs0
[348.377052] Dynamic subtest bcs0: SKIP (0.000s)
[348.387077] Starting dynamic subtest: vcs0
[348.391641] Dynamic subtest vcs0: SKIP (0.000s)
[348.402104] Starting dynamic subtest: vcs1
[348.406706] Dynamic subtest vcs1: SKIP (0.000s)
[348.416708] Starting dynamic subtest: vecs0
[348.421687] Dynamic subtest vecs0: SKIP (0.000s)
[348.433515] Starting dynamic subtest: ccs0
[348.437804] Dynamic subtest ccs0: SKIP (0.000s)
[348.441972] Subtest busy-idle: SKIP (0.032s)
[348.480951] [073/156] (671s left) kms_vrr (flip-dpms)
[348.573191] Starting subtest: flip-dpms
[348.580259] Subtest flip-dpms: SKIP (0.000s)
[348.660792] [074/156] (671s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[348.781263] Starting subtest: fbcpsr-suspend
[388.716176] Subtest fbcpsr-suspend: SUCCESS (10.088s)
[388.855904] [075/156] (631s left) kms_cursor_crc (cursor-sliding-128x42)
[389.086273] Starting subtest: cursor-sliding-128x42
[389.144600] Subtest cursor-sliding-128x42: SKIP (0.051s)
[389.357385] [076/156] (630s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[389.453942] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[389.458418] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[389.554922] [077/156] (630s left) syncobj_timeline (multi-wait-available-submitted)
[389.619615] Starting subtest: multi-wait-available-submitted
[389.621623] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[389.729307] [078/156] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[389.831375] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[393.741010] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.862s)
[394.917424] [079/156] (625s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[395.013906] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[395.018467] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[395.114381] [080/156] (625s left) syncobj_timeline (reset-multiple-signaled)
[395.168569] Starting subtest: reset-multiple-signaled
[395.170821] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[395.288360] [081/156] (625s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt)
[395.386259] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt
[395.390635] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[395.484052] [082/156] (624s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[395.579913] Starting subtest: psrhdr-rgb101010-draw-pwrite
[395.584127] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[395.692848] [083/156] (624s left) gem_exec_schedule (thriceslice)
[395.761326] Starting subtest: thriceslice
[395.763306] Starting dynamic subtest: rcs0
[395.782504] Dynamic subtest rcs0: SUCCESS (0.029s)
[395.795608] Starting dynamic subtest: bcs0
[395.811065] Dynamic subtest bcs0: SUCCESS (0.027s)
[395.821671] Starting dynamic subtest: vcs0
[395.840603] Dynamic subtest vcs0: SUCCESS (0.029s)
[395.850843] Starting dynamic subtest: vcs1
[395.871214] Dynamic subtest vcs1: SUCCESS (0.029s)
[395.882238] Starting dynamic subtest: vecs0
[395.906894] Dynamic subtest vecs0: SUCCESS (0.034s)
[395.919097] Starting dynamic subtest: ccs0
[395.939302] Dynamic subtest ccs0: SUCCESS (0.029s)
[395.941499] Subtest thriceslice: SUCCESS (0.186s)
[397.475516] [084/156] (623s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[397.587892] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[398.707111] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.113s)
[398.824089] [085/156] (621s left) gem_exec_schedule (pi-distinct-iova)
[398.998669] Starting subtest: pi-distinct-iova
[399.001005] Starting dynamic subtest: rcs0
[399.076076] Dynamic subtest rcs0: SUCCESS (0.081s)
[399.087851] Starting dynamic subtest: vcs0
[399.130311] Dynamic subtest vcs0: SUCCESS (0.052s)
[399.141357] Starting dynamic subtest: vcs1
[399.188957] Dynamic subtest vcs1: SUCCESS (0.058s)
[399.200271] Starting dynamic subtest: vecs0
[399.252089] Dynamic subtest vecs0: SUCCESS (0.061s)
[399.262636] Starting dynamic subtest: ccs0
[399.313788] Dynamic subtest ccs0: SUCCESS (0.059s)
[399.316163] Subtest pi-distinct-iova: SUCCESS (0.319s)
[400.562215] [086/156] (620s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[400.655775] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[400.660555] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[400.727898] [087/156] (619s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[400.847101] Starting subtest: cursorA-vs-flipB-atomic-transitions
[400.851828] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[400.995749] [088/156] (619s left) api_intel_bb (blit-noreloc-keep-cache)
[401.055453] Starting subtest: blit-noreloc-keep-cache
[401.063741] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[401.194987] [089/156] (619s left) core_getversion (all-cards)
[401.231426] Starting subtest: all-cards
[401.239375] Subtest all-cards: SUCCESS (0.012s)
[401.280366] [090/156] (619s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[401.385635] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[401.390094] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[401.475549] [091/156] (619s left) kms_vblank (query-idle)
[401.561496] Starting subtest: query-idle
[401.563103] Starting dynamic subtest: pipe-A-eDP-1
[403.325365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s)
[403.343339] Starting dynamic subtest: pipe-D-eDP-1
[405.781097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.447s)
[405.782995] Subtest query-idle: SUCCESS (4.206s)
[406.615529] [092/156] (614s left) device_reset (unbind-cold-reset-rebind)
[406.662645] Starting subtest: unbind-cold-reset-rebind
[406.667432] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[406.753444] [093/156] (614s left) kms_psr (fbc-pr-no-drrs)
[406.846717] Starting subtest: fbc-pr-no-drrs
[406.851220] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[406.923102] [094/156] (614s left) kms_flip (2x-blocking-absolute-wf_vblank)
[407.014824] Starting subtest: 2x-blocking-absolute-wf_vblank
[407.027461] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[407.108449] [095/156] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[407.206963] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[413.636666] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.425s)
[414.829925] [096/156] (606s left) kms_flip (2x-flip-vs-panning-vs-hang)
[414.933680] Starting subtest: 2x-flip-vs-panning-vs-hang
[414.937800] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[415.034270] [097/156] (606s left) kms_plane_multiple (tiling-4)
[415.124162] Starting subtest: tiling-4
[415.126083] Starting dynamic subtest: pipe-A-eDP-1
[418.966487] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.843s)
[418.977778] Starting dynamic subtest: pipe-B-eDP-1
[423.513887] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.549s)
[423.526956] Starting dynamic subtest: pipe-C-eDP-1
[428.064234] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.548s)
[428.078290] Starting dynamic subtest: pipe-D-eDP-1
[432.529537] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.463s)
[432.532092] Subtest tiling-4: SUCCESS (17.408s)
[433.336101] [098/156] (587s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[433.438341] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[433.442262] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[433.546164] [099/156] (587s left) kms_cursor_edge_walk (64x64-top-bottom)
[433.640126] Starting subtest: 64x64-top-bottom
[433.642410] Starting dynamic subtest: pipe-A-eDP-1
[437.100587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[437.113336] Starting dynamic subtest: pipe-D-eDP-1
[440.309576] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.206s)
[440.311466] Subtest 64x64-top-bottom: SUCCESS (6.669s)
[441.121334] [100/156] (580s left) gem_exec_fence (concurrent)
[441.305189] Starting subtest: concurrent
[441.309819] Subtest concurrent: SKIP (0.000s)
[443.558701] [101/156] (577s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[443.666213] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[443.670634] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[443.765744] [102/156] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[443.860189] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[451.286190] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.430s)
[451.423459] [103/156] (569s left) gem_basic (multigpu-create-close)
[451.481212] Starting subtest: multigpu-create-close
[451.485726] Subtest multigpu-create-close: SKIP (0.000s)
[451.586756] [104/156] (569s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[451.686776] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[451.690761] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[451.799288] [105/156] (569s left) vgem_basic (mmap)
[451.849215] Starting subtest: mmap
[451.855892] Subtest mmap: SUCCESS (0.008s)
[451.917632] [106/156] (569s left) kms_lease (possible-crtcs-filtering)
[452.014114] Starting subtest: possible-crtcs-filtering
[452.019701] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[452.128567] [107/156] (569s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[452.226461] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[453.429378] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.201s)
[453.558692] [108/156] (568s left) kms_flip (2x-flip-vs-rmfb)
[453.647736] Starting subtest: 2x-flip-vs-rmfb
[453.660045] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[453.738163] [109/156] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[453.838753] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[457.951390] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.114s)
[459.155644] [110/156] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[459.265094] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[459.269243] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[459.363293] [111/156] (562s left) prime_vgem (fence-flip-hang)
[459.460807] Subtest fence-flip-hang: SKIP (0.000s)
[459.585168] [112/156] (562s left) kms_pm_rpm (pc8-residency)
[461.628487] Starting subtest: pc8-residency
[461.633284] Subtest pc8-residency: SKIP (0.000s)
[462.041043] [113/156] (559s left) gem_spin_batch (engines)
[462.089648] Starting subtest: engines
[462.092137] Starting dynamic subtest: rcs0
[465.335006] Dynamic subtest rcs0: SUCCESS (3.237s)
[465.359089] Starting dynamic subtest: bcs0
[468.572240] Dynamic subtest bcs0: SUCCESS (3.234s)
[468.583900] Starting dynamic subtest: vcs0
[471.810122] Dynamic subtest vcs0: SUCCESS (3.233s)
[471.828596] Starting dynamic subtest: vcs1
[475.043198] Dynamic subtest vcs1: SUCCESS (3.229s)
[475.056450] Starting dynamic subtest: vecs0
[478.282062] Dynamic subtest vecs0: SUCCESS (3.234s)
[478.297823] Starting dynamic subtest: ccs0
[481.522099] Dynamic subtest ccs0: SUCCESS (3.236s)
[481.524409] Subtest engines: SUCCESS (19.423s)
[481.761169] [114/156] (540s left) gem_userptr_blits (vma-merge)
[481.826993] Starting subtest: vma-merge
[481.874293] Subtest vma-merge: SUCCESS (0.048s)
[482.008727] [115/156] (539s left) gem_exec_reloc (basic-concurrent0)
[482.070246] Subtest basic-concurrent0: SKIP (0.000s)
[482.164249] [116/156] (539s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt)
[482.280256] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt
[482.284616] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[482.374820] [117/156] (539s left) prime_busy (hang)
[482.427094] Starting subtest: hang
[482.429531] Starting dynamic subtest: rcs0
[508.946325] Dynamic subtest rcs0: SUCCESS (26.518s)
[508.958973] Starting dynamic subtest: bcs0
[516.104970] Dynamic subtest bcs0: SUCCESS (7.157s)
[516.115472] Starting dynamic subtest: vcs0
[523.076843] Dynamic subtest vcs0: SUCCESS (6.973s)
[523.090094] Starting dynamic subtest: vcs1
[530.116291] Dynamic subtest vcs1: SUCCESS (7.035s)
[530.126723] Starting dynamic subtest: vecs0
[537.090930] Dynamic subtest vecs0: SUCCESS (6.971s)
[537.102063] Starting dynamic subtest: ccs0
[551.001997] Dynamic subtest ccs0: SUCCESS (13.906s)
[551.004496] Subtest hang: SUCCESS (68.569s)
[551.153829] [118/156] (470s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[551.282445] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[551.286904] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[551.431812] [119/156] (470s left) kms_chamelium_hpd (hdmi-hpd)
[551.812830] Subtest hdmi-hpd: SKIP (0.000s)
[552.620100] [120/156] (469s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[554.557903] Starting subtest: dpms-mode-unset-lpsp
[558.661164] Subtest dpms-mode-unset-lpsp: SUCCESS (4.106s)
[559.051219] [121/156] (463s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[559.148513] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[559.152545] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[559.271607] [122/156] (462s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[559.367263] Starting subtest: bad-aux-stride-yf-tiled-ccs
[559.369448] Starting dynamic subtest: pipe-A-eDP-1
[559.391675] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[559.407067] Starting dynamic subtest: pipe-B-eDP-1
[559.429060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[559.439359] Starting dynamic subtest: pipe-C-eDP-1
[559.461185] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[559.471253] Starting dynamic subtest: pipe-D-eDP-1
[559.493670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[559.497810] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[561.709678] [123/156] (460s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[561.818616] Starting subtest: fbchdr-tiling-4
[561.822619] Subtest fbchdr-tiling-4: SKIP (0.000s)
[561.924984] [124/156] (460s left) gem_mmap_wc (bad-object)
[561.978302] Subtest bad-object: SKIP (0.000s)
[562.034307] [125/156] (460s left) prime_mmap (test_refcounting)
[562.095860] Starting subtest: test_refcounting
[562.098207] Starting dynamic subtest: test_refcounting-smem
[562.126350] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[562.128886] Subtest test_refcounting: SUCCESS (0.034s)
[562.241925] [126/156] (460s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[562.357758] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[562.362202] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[562.468359] [127/156] (459s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[563.011384] Starting subtest: syncobj-timeline-invalid-wait
[563.014088] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[564.484445] [128/156] (458s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[564.590664] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[564.595202] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[564.702460] [129/156] (457s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[564.811595] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[564.815786] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[564.909436] [130/156] (457s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[565.028266] Starting subtest: modeset-atomic-cursor-hotspot
[565.032773] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[565.186677] [131/156] (457s left) gem_exec_reloc (basic-gtt)
[565.249779] Subtest basic-gtt: SKIP (0.000s)
[565.326562] [132/156] (457s left) kms_addfb_basic (no-handle)
[565.390355] Starting subtest: no-handle
[565.392610] Subtest no-handle: SUCCESS (0.000s)
[565.536023] [133/156] (457s left) kms_flip (plain-flip-interruptible)
[565.634469] Starting subtest: plain-flip-interruptible
[565.636111] Starting dynamic subtest: A-eDP1
[567.309058] Dynamic subtest A-eDP1: SUCCESS (1.672s)
[567.322335] Starting dynamic subtest: B-eDP1
[568.951938] Dynamic subtest B-eDP1: SUCCESS (1.641s)
[568.965442] Starting dynamic subtest: C-eDP1
[570.580415] Dynamic subtest C-eDP1: SUCCESS (1.626s)
[570.597737] Starting dynamic subtest: D-eDP1
[572.210961] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[572.213528] Subtest plain-flip-interruptible: SUCCESS (6.577s)
[573.396498] [134/156] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[573.504701] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[573.509352] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[573.604480] [135/156] (449s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[573.703049] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[573.705280] Starting dynamic subtest: pipe-A-eDP-1
[573.726947] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.741355] Starting dynamic subtest: pipe-B-eDP-1
[573.762708] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.773095] Starting dynamic subtest: pipe-C-eDP-1
[573.794762] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[573.805136] Starting dynamic subtest: pipe-D-eDP-1
[573.827368] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.831427] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[575.974471] [136/156] (446s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[576.082232] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[576.086160] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[576.212759] [137/156] (446s left) gem_ctx_persistence (hang)
[576.281625] Starting subtest: hang
[576.286067] Subtest hang: SKIP (0.000s)
[576.387018] [138/156] (446s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[576.480145] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[576.484937] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[577.590294] [139/156] (445s left) gem_exec_schedule (wide)
[577.770374] Starting subtest: wide
[577.777817] Starting dynamic subtest: rcs0
[587.963539] Dynamic subtest rcs0: SUCCESS (10.189s)
[587.980517] Starting dynamic subtest: vcs0
[597.817588] Dynamic subtest vcs0: SUCCESS (9.851s)
[597.831608] Starting dynamic subtest: vcs1
[609.760622] Dynamic subtest vcs1: SUCCESS (11.938s)
[609.774406] Starting dynamic subtest: vecs0
[621.043725] Dynamic subtest vecs0: SUCCESS (11.285s)
[621.055541] Starting dynamic subtest: ccs0
[635.899170] Dynamic subtest ccs0: SUCCESS (14.856s)
[635.901825] Subtest wide: SUCCESS (58.126s)
[638.136865] [140/156] (384s left) kms_psr (psr-sprite-plane-onoff)
[638.235598] Starting subtest: psr-sprite-plane-onoff
[638.237988] Starting dynamic subtest: eDP-1
[640.012898] Dynamic subtest eDP-1: SUCCESS (1.778s)
[640.015291] Subtest psr-sprite-plane-onoff: SUCCESS (1.779s)
[640.859609] [141/156] (382s left) kms_plane (plane-position-hole)
[640.959014] Starting subtest: plane-position-hole
[641.489531] Starting dynamic subtest: pipe-A-plane-1
[642.771470] Dynamic subtest pipe-A-plane-1: SUCCESS (1.280s)
[642.783630] Starting dynamic subtest: pipe-A-plane-2
[644.075017] Dynamic subtest pipe-A-plane-2: SUCCESS (1.303s)
[644.087216] Starting dynamic subtest: pipe-A-plane-3
[645.418280] Dynamic subtest pipe-A-plane-3: SUCCESS (1.342s)
[645.431471] Starting dynamic subtest: pipe-A-plane-4
[646.732861] Dynamic subtest pipe-A-plane-4: SUCCESS (1.314s)
[646.743901] Starting dynamic subtest: pipe-A-plane-5
[646.761211] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[647.996953] Starting dynamic subtest: pipe-B-plane-1
[649.309261] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[649.321904] Starting dynamic subtest: pipe-B-plane-2
[650.663630] Dynamic subtest pipe-B-plane-2: SUCCESS (1.352s)
[650.679094] Starting dynamic subtest: pipe-B-plane-3
[651.985139] Dynamic subtest pipe-B-plane-3: SUCCESS (1.321s)
[651.999857] Starting dynamic subtest: pipe-B-plane-4
[653.311730] Dynamic subtest pipe-B-plane-4: SUCCESS (1.323s)
[653.327424] Starting dynamic subtest: pipe-B-plane-5
[653.335400] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[653.338087] Subtest plane-position-hole: SUCCESS (12.376s)
[654.174039] [142/156] (368s left) gem_pread (uncached)
[654.236789] Subtest uncached: SKIP (0.000s)
[654.296361] [143/156] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[654.402703] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[660.976376] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.579s)
[661.129513] [144/156] (362s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[661.235442] Starting subtest: y-tiled-32bpp-rotate-90
[661.239808] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[661.334088] [145/156] (361s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[661.378409] Starting subtest: etime-multi-wait-all-available-unsubmitted
[661.484674] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[661.565420] [146/156] (361s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[661.682428] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[661.686916] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[661.773419] [147/156] (361s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[661.878738] Starting subtest: fbc-rgb565-draw-pwrite
[666.520848] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.647s)
[667.736326] [148/156] (355s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[667.839663] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[667.843773] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[667.949725] [149/156] (355s left) kms_getfb (getfb2-handle-not-fb)
[668.043067] Starting subtest: getfb2-handle-not-fb
[668.045311] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[668.150111] [150/156] (355s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff)
[668.253801] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff
[668.257888] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[668.369407] [151/156] (355s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[668.475977] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[673.052547] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.582s)
[674.212024] [152/156] (349s left) perf (per-context-mode-unprivileged)
[674.340200] Starting subtest: per-context-mode-unprivileged
[674.343976] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[674.386916] [153/156] (349s left) gem_eio (in-flight-internal-1us)
[674.610078] Starting subtest: in-flight-internal-1us
[676.556837] Subtest in-flight-internal-1us: SUCCESS (1.945s)
[676.716459] [154/156] (346s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[676.816102] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[681.309913] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.498s)
[682.524831] [155/156] (341s left) perf_pmu (busy-check-all)
[682.568160] Starting subtest: busy-check-all
[682.570513] Starting dynamic subtest: rcs0
[683.122850] Dynamic subtest rcs0: SUCCESS (0.556s)
[683.137000] Starting dynamic subtest: bcs0
[683.678792] Dynamic subtest bcs0: SUCCESS (0.553s)
[683.693149] Starting dynamic subtest: vcs0
[685.433793] Dynamic subtest vcs0: SUCCESS (1.750s)
[685.448101] Starting dynamic subtest: vcs1
[687.480643] Dynamic subtest vcs1: SUCCESS (2.043s)
[687.494949] Starting dynamic subtest: vecs0
[689.465503] Dynamic subtest vecs0: SUCCESS (1.982s)
[689.479584] Starting dynamic subtest: ccs0
[690.020389] Dynamic subtest ccs0: SUCCESS (0.554s)
[690.022945] Subtest busy-check-all: SUCCESS (7.455s)
[690.139533] [156/156] (333s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[690.293804] Starting subtest: dp-mst-type-0-suspend-resume
[690.298431] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[690.414742] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: gem_exec_nop
results: parsing output: 3/ for test: vgem_basic
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_pm_rps
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_atomic
results: parsing output: 16/ for test: gem_flink_race
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gen9_exec_parse
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: sysfs_heartbeat_interval
results: parsing output: 33/ for test: kms_chamelium_edid
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_chamelium_audio
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: i915_pm_rps
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_invalid_mode
results: parsing output: 49/ for test: kms_dsc
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: gem_ctx_create
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_plane_cursor
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_vrr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: core_getversion
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: device_reset
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_plane_multiple
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_edge_walk
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_basic
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: vgem_basic
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: prime_vgem
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: prime_busy
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: prime_mmap
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: kms_flip
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_ccs
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_ctx_persistence
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: gem_exec_schedule
results: parsing output: 139/ for test: kms_psr
results: parsing output: 140/ for test: kms_plane
results: parsing output: 141/ for test: gem_pread
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_frontbuffer_tracking
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_getfb
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: gem_eio
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: perf_pmu
results: parsing output: 155/ for test: kms_content_protection
Done.