[55.717696] Initializing watchdogs
[55.717782]   /dev/watchdog0
[55.731873] [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]
[55.736093] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.738309] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.742054] [001/156] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[55.885409] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[55.889703] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[55.990885] [002/156] (960s left) kms_lease (page-flip-implicit-plane)
[56.089046] Starting subtest: page-flip-implicit-plane
[56.091421] Starting dynamic subtest: pipe-A-eDP-1
[56.582659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.507s)
[56.590057] Starting dynamic subtest: pipe-B-eDP-1
[57.698461] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[57.705590] Starting dynamic subtest: pipe-C-eDP-1
[58.801413] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[58.810195] Starting dynamic subtest: pipe-D-eDP-1
[59.911219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[59.913124] Subtest page-flip-implicit-plane: SUCCESS (3.911s)
[60.727247] [003/156] (955s left) prime_vgem (basic-fence-read)
[60.843969] Starting subtest: basic-fence-read
[60.851986] Subtest basic-fence-read: SKIP (0.006s)
[60.962604] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[60.965373] [004/156] (955s left) kms_atomic (test-only)
[61.063633] Starting subtest: test-only
[61.133969] Starting dynamic subtest: pipe-A-eDP-1
[63.619464] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.516s)
[63.621864] Subtest test-only: SUCCESS (2.590s)
[64.483654] [005/156] (951s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[64.531727] Starting subtest: multi-wait-for-submit-available-submitted
[64.534164] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[64.619756] [006/156] (951s left) gem_mmap_offset (isolation)
[64.666970] Starting subtest: isolation
[64.685345] Subtest isolation: SUCCESS (0.006s)
[64.811531] [007/156] (951s left) kms_flip (2x-plain-flip-ts-check)
[64.906727] Starting subtest: 2x-plain-flip-ts-check
[64.915411] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[65.004449] [008/156] (951s left) gem_mmap_gtt (bad-object)
[65.066841] Subtest bad-object: SKIP (0.000s)
[65.124382] [009/156] (951s left) kms_psr (pr-no-drrs)
[65.213019] Starting subtest: pr-no-drrs
[65.217631] Subtest pr-no-drrs: SKIP (0.000s)
[65.296716] [010/156] (951s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[65.398069] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[65.401971] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[65.504568] [011/156] (951s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[65.606843] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[65.610543] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[65.708659] [012/156] (950s left) gem_madvise (dontneed-before-pwrite)
[65.740483] Starting subtest: dontneed-before-pwrite
[65.762695] Subtest dontneed-before-pwrite: SKIP (0.020s)
[65.830776] [013/156] (950s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[65.913436] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[65.917022] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[65.992623] [014/156] (950s left) kms_psr (psr2-primary-mmap-gtt)
[66.092504] Starting subtest: psr2-primary-mmap-gtt
[66.094559] Starting dynamic subtest: eDP-1
[67.559761] Dynamic subtest eDP-1: SKIP (1.474s)
[67.564818] Subtest psr2-primary-mmap-gtt: SKIP (1.475s)
[67.684875] [015/156] (949s left) gem_exec_whisper (basic-contexts-forked-all)
[67.741083] Starting subtest: basic-contexts-forked-all
[88.265028] Subtest basic-contexts-forked-all: SUCCESS (20.560s)
[88.490449] [016/156] (928s left) gem_exec_flush (basic-uc-set-default)
[88.544662] Starting subtest: basic-uc-set-default
[94.007180] Subtest basic-uc-set-default: SUCCESS (5.460s)
[94.191672] [017/156] (922s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[94.297893] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[94.302446] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[94.371190] [018/156] (922s left) kms_cursor_legacy (forked-bo)
[94.483979] Starting subtest: forked-bo
[94.486186] Starting dynamic subtest: pipe-A
[99.965615] Dynamic subtest pipe-A: SUCCESS (5.478s)
[99.979864] Starting dynamic subtest: pipe-B
[105.430269] Dynamic subtest pipe-B: SUCCESS (5.463s)
[105.438774] Starting dynamic subtest: pipe-C
[110.908383] Dynamic subtest pipe-C: SUCCESS (5.476s)
[110.925866] Starting dynamic subtest: pipe-D
[116.373070] Dynamic subtest pipe-D: SUCCESS (5.463s)
[116.387323] Starting dynamic subtest: all-pipes
[121.867119] Dynamic subtest all-pipes: SUCCESS (5.492s)
[121.869714] Subtest forked-bo: SUCCESS (27.377s)
[122.027203] [019/156] (894s left) perf_pmu (busy-accuracy-98)
[122.071069] Starting subtest: busy-accuracy-98
[122.073129] Starting dynamic subtest: rcs0
[125.109629] Dynamic subtest rcs0: SUCCESS (3.037s)
[125.120030] Starting dynamic subtest: bcs0
[128.166101] Dynamic subtest bcs0: SUCCESS (3.055s)
[128.177280] Starting dynamic subtest: vcs0
[131.207292] Dynamic subtest vcs0: SUCCESS (3.041s)
[131.220800] Starting dynamic subtest: vcs1
[134.247531] Dynamic subtest vcs1: SUCCESS (3.039s)
[134.261905] Starting dynamic subtest: vecs0
[137.292773] Dynamic subtest vecs0: SUCCESS (3.044s)
[137.303215] Starting dynamic subtest: ccs0
[140.343783] Dynamic subtest ccs0: SUCCESS (3.050s)
[140.346289] Subtest busy-accuracy-98: SUCCESS (18.271s)
[140.459510] [020/156] (876s left) api_intel_allocator (fork-simple-once)
[140.516763] Starting subtest: fork-simple-once
[140.532407] Subtest fork-simple-once: SUCCESS (0.018s)
[140.663242] [021/156] (876s left) gem_mmap_wc (read-write)
[140.711824] Subtest read-write: SKIP (0.000s)
[140.770937] [022/156] (876s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[140.865957] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[140.868248] Starting dynamic subtest: pipe-A-eDP-1
[140.891609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[140.900435] Starting dynamic subtest: pipe-B-eDP-1
[140.921057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[140.928774] Starting dynamic subtest: pipe-C-eDP-1
[140.949978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[140.957816] Starting dynamic subtest: pipe-D-eDP-1
[140.979821] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[140.984239] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[143.108921] [023/156] (874s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[143.205413] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[143.209635] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[143.312640] [024/156] (873s left) prime_busy (after-wait)
[143.366423] Starting subtest: after-wait
[143.371228] Starting dynamic subtest: rcs0
[143.403841] Dynamic subtest rcs0: SUCCESS (0.034s)
[143.415060] Starting dynamic subtest: bcs0
[143.445113] Dynamic subtest bcs0: SUCCESS (0.041s)
[143.453981] Starting dynamic subtest: vcs0
[143.487267] Dynamic subtest vcs0: SUCCESS (0.042s)
[143.498216] Starting dynamic subtest: vcs1
[143.527716] Dynamic subtest vcs1: SUCCESS (0.039s)
[143.536875] Starting dynamic subtest: vecs0
[143.567765] Dynamic subtest vecs0: SUCCESS (0.040s)
[143.576565] Starting dynamic subtest: ccs0
[143.608979] Dynamic subtest ccs0: SUCCESS (0.041s)
[143.716908] Subtest after-wait: SUCCESS (0.349s)
[143.790772] [025/156] (873s left) gem_userptr_blits (vma-merge)
[143.858263] Starting subtest: vma-merge
[143.902370] Subtest vma-merge: SUCCESS (0.044s)
[144.012180] [026/156] (873s left) kms_getfb (getfb-handle-not-fb)
[144.103266] Starting subtest: getfb-handle-not-fb
[144.105707] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[144.219812] [027/156] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[144.326608] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[144.331033] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[144.426955] [028/156] (872s left) gem_fenced_exec_thrash (2-spare-fences)
[144.487803] Subtest 2-spare-fences: SKIP (0.000s)
[144.556185] [029/156] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[144.662260] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[144.666109] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[144.740911] [030/156] (872s left) kms_cdclk (mode-transition)
[144.841793] Starting subtest: mode-transition
[144.843957] Starting dynamic subtest: pipe-A-eDP-1
[145.139057] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[145.147913] Starting dynamic subtest: pipe-B-eDP-1
[145.152646] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[145.163936] Starting dynamic subtest: pipe-C-eDP-1
[145.169229] Dynamic subtest pipe-C-eDP-1: SKIP (0.004s)
[145.183257] Starting dynamic subtest: pipe-D-eDP-1
[145.187918] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[145.192426] Subtest mode-transition: SKIP (0.307s)
[145.944453] [031/156] (871s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[146.047495] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[146.049795] Starting dynamic subtest: pipe-A-eDP-1
[146.069886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[146.080759] Starting dynamic subtest: pipe-B-eDP-1
[146.099244] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[146.107831] Starting dynamic subtest: pipe-C-eDP-1
[146.128058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[146.136975] Starting dynamic subtest: pipe-D-eDP-1
[146.157203] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[146.159395] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[148.302680] [032/156] (869s left) gem_exec_parallel (userptr)
[148.357541] Starting subtest: userptr
[148.360171] Starting dynamic subtest: rcs0
[149.808082] Dynamic subtest rcs0: SUCCESS (1.450s)
[149.821115] Starting dynamic subtest: bcs0
[151.267252] Dynamic subtest bcs0: SUCCESS (1.458s)
[151.276095] Starting dynamic subtest: vcs0
[153.281399] Dynamic subtest vcs0: SUCCESS (2.012s)
[153.293532] Starting dynamic subtest: vcs1
[155.264520] Dynamic subtest vcs1: SUCCESS (1.982s)
[155.274400] Starting dynamic subtest: vecs0
[157.312277] Dynamic subtest vecs0: SUCCESS (2.047s)
[157.323731] Starting dynamic subtest: ccs0
[158.825973] Dynamic subtest ccs0: SUCCESS (1.514s)
[158.828404] Subtest userptr: SUCCESS (10.469s)
[159.023238] [033/156] (858s left) kms_flip (2x-busy-flip)
[159.129352] Starting subtest: 2x-busy-flip
[159.137838] Subtest 2x-busy-flip: SKIP (0.010s)
[159.212833] [034/156] (858s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[159.304090] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[159.308044] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[159.405435] [035/156] (858s left) kms_debugfs (display-on-read-all)
[159.515075] Starting subtest: display-on-read-all
[159.689562] Subtest display-on-read-all: SUCCESS (0.174s)
[159.810309] [036/156] (857s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[159.903776] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[159.908343] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[159.985138] [037/156] (857s left) kms_frontbuffer_tracking (hdr-suspend)
[160.096075] Starting subtest: hdr-suspend
[160.099818] Subtest hdr-suspend: SKIP (0.000s)
[160.187072] [038/156] (857s left) gem_softpin (full)
[160.245240] Starting subtest: full
[160.253447] Subtest full: SUCCESS (0.008s)
[160.390958] [039/156] (857s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[160.490555] Starting subtest: fbchdr-rgb565-draw-blt
[160.494266] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[160.580661] [040/156] (857s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[160.697428] Starting subtest: cursor-vs-flip-atomic
[190.472689] Subtest cursor-vs-flip-atomic: SUCCESS (29.772s)
[191.344819] [041/156] (826s left) syncobj_timeline (32bits-limit)
[191.400260] Starting subtest: 32bits-limit
[191.402711] Subtest 32bits-limit: SUCCESS (0.001s)
[191.517180] [042/156] (826s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[191.612694] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[191.616952] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[191.704660] [043/156] (826s left) kms_cursor_crc (cursor-onscreen-32x10)
[191.873712] Starting subtest: cursor-onscreen-32x10
[191.917748] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[192.188893] [044/156] (825s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[192.282164] Starting subtest: x-tiled-16bpp-rotate-180
[193.516287] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.235s)
[193.646931] [045/156] (824s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[193.766508] Starting subtest: cursorA-vs-flipB-varying-size
[193.770158] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[193.909225] [046/156] (824s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[194.052316] Starting subtest: dp-mst-type-1-suspend-resume
[194.055967] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[194.188892] [047/156] (823s left) syncobj_timeline (single-wait-signaled)
[194.239126] Starting subtest: single-wait-signaled
[194.241123] Subtest single-wait-signaled: SUCCESS (0.000s)
[194.342170] [048/156] (823s left) dumb_buffer (create-clear)
[194.391464] Starting subtest: create-clear
[228.913031] Subtest create-clear: SUCCESS (34.516s)
[229.019659] [049/156] (789s left) perf (polling)
[229.135761] Starting subtest: polling
[229.137983] Starting dynamic subtest: 0-rcs0
[239.144878] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[239.155142] Starting dynamic subtest: 1-vcs1
[249.165368] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[249.167947] Subtest polling: SUCCESS (20.030s)
[249.213085] [050/156] (769s left) kms_chamelium_hpd (dp-hpd-storm)
[249.592226] Subtest dp-hpd-storm: SKIP (0.000s)
[250.450295] [051/156] (767s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[250.540593] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[250.544686] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[250.650040] [052/156] (767s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[250.750547] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[258.113079] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.368s)
[258.261743] [053/156] (760s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[258.359932] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[258.364103] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.461669] [054/156] (759s left) gem_exec_big (single)
[258.516943] Starting subtest: single
[263.425705] Subtest single: SUCCESS (4.906s)
[263.659804] [055/156] (754s left) syncobj_wait (wait-for-submit-complex)
[263.757885] Starting subtest: wait-for-submit-complex
[263.821473] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[263.897258] [056/156] (754s left) kms_chamelium_frames (vga-frame-dump)
[264.306880] Subtest vga-frame-dump: SKIP (0.000s)
[265.119988] [057/156] (753s left) syncobj_wait (invalid-reset-one-illegal-handle)
[265.176634] Starting subtest: invalid-reset-one-illegal-handle
[265.178822] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[265.272897] [058/156] (753s left) gem_exec_reloc (basic-write-cpu-noreloc)
[265.337832] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[265.392334] [059/156] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[265.503476] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[272.885923] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.390s)
[273.032104] [060/156] (745s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[273.086798] Starting subtest: rel-constants-invalid-rel-gen5
[273.089139] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[273.214232] [061/156] (745s left) kms_cursor_crc (cursor-random-256x256)
[273.446470] Starting subtest: cursor-random-256x256
[273.452264] Starting dynamic subtest: pipe-A-eDP-1
[276.818921] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.368s)
[276.849087] Starting dynamic subtest: pipe-D-eDP-1
[280.876390] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.036s)
[280.878795] Subtest cursor-random-256x256: SUCCESS (7.429s)
[281.732349] [062/156] (737s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[281.840180] Starting subtest: fbc-2p-pri-indfb-multidraw
[281.844151] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[281.952595] [063/156] (736s left) kms_plane_lowres (tiling-none)
[282.045708] Starting subtest: tiling-none
[282.047871] Starting dynamic subtest: pipe-A-eDP-1
[282.052163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.357467] Starting dynamic subtest: pipe-B-eDP-1
[282.361914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.371310] Starting dynamic subtest: pipe-C-eDP-1
[282.375733] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.385306] Starting dynamic subtest: pipe-D-eDP-1
[282.389628] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.393958] Subtest tiling-none: SKIP (0.311s)
[283.167149] [064/156] (735s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[283.263394] Starting subtest: fbcpsr-tiling-y
[283.267522] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[283.360953] [065/156] (735s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[283.464698] Starting subtest: primary-x-tiled-reflect-x-0
[290.448518] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.987s)
[291.628739] [066/156] (727s left) gem_render_copy (yf-tiled)
[291.686390] Starting subtest: yf-tiled
[291.691162] Subtest yf-tiled: SKIP (0.000s)
[291.866566] [067/156] (727s left) gem_busy (close-race)
[291.932869] Starting subtest: close-race
[315.264843] Subtest close-race: SUCCESS (23.329s)
[315.647523] [068/156] (703s left) kms_hdmi_inject (inject-audio)
[316.026193] Starting subtest: inject-audio
[316.328944] Subtest inject-audio: SUCCESS (0.304s)
[316.884397] [069/156] (702s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[317.004847] Starting subtest: fbc-rgb565-draw-pwrite
[321.600940] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.599s)
[322.770759] [070/156] (696s left) prime_mmap (test_invalid_sync_flags)
[322.825195] Starting subtest: test_invalid_sync_flags
[322.827603] Starting dynamic subtest: test_invalid_sync_flags-smem
[322.829579] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[322.831538] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[322.942414] [071/156] (696s left) gem_lmem_swapping (heavy-random)
[322.993619] Subtest heavy-random: SKIP (0.000s)
[323.038253] [072/156] (696s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[323.146117] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[323.150491] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[323.252832] [073/156] (695s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[323.364628] Starting subtest: y-tiled-64bpp-rotate-0
[323.368782] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[323.448359] [074/156] (695s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[323.553162] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[323.557276] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[323.660797] [075/156] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[323.756122] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[323.759511] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[323.857886] [076/156] (695s left) i915_pciid
[324.012261] [077/156] (695s left) testdisplay
[324.323073] [078/156] (695s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[324.426178] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[325.196139] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.770s)
[325.358048] [079/156] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[325.445370] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[329.715610] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.275s)
[330.868543] [080/156] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[330.961821] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[330.965812] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[331.065411] [081/156] (688s left) kms_selftest (drm_format_helper)
[331.104045] Starting subtest: drm_format_helper
[331.161063] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[331.267306] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.106s)
[331.279317] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[331.366091] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.097s)
[331.377571] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[331.474352] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.107s)
[331.484582] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[331.589156] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.114s)
[331.599237] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[331.692148] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.103s)
[331.704260] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[331.808961] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.112s)
[331.818879] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[331.903923] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.097s)
[331.914804] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[332.022079] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.117s)
[332.032940] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[332.124373] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.099s)
[332.135611] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[332.225760] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.101s)
[332.236181] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[332.334887] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.108s)
[332.345750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[332.432236] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.095s)
[332.443064] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[332.518945] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.087s)
[332.530111] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[332.626420] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.107s)
[332.638043] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[332.739740] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.113s)
[332.748966] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[332.832332] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.090s)
[332.840803] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[332.955531] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.122s)
[332.957278] Subtest drm_format_helper: SUCCESS (1.851s)
[333.121458] [082/156] (686s left) perf (low-oa-exponent-permissions)
[333.225350] Starting subtest: low-oa-exponent-permissions
[333.256678] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[333.297395] [083/156] (686s left) kms_psr (psr-suspend)
[333.383114] Starting subtest: psr-suspend
[333.386589] Starting dynamic subtest: eDP-1
[351.583122] Dynamic subtest eDP-1: SUCCESS (3.074s)
[351.585424] Subtest psr-suspend: SUCCESS (3.075s)
[352.392622] [084/156] (667s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[352.499229] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[352.503163] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[352.564866] [085/156] (667s left) kms_psr (fbc-psr-primary-mmap-cpu)
[352.652439] Starting subtest: fbc-psr-primary-mmap-cpu
[352.654344] Starting dynamic subtest: eDP-1
[352.658342] Dynamic subtest eDP-1: SKIP (0.000s)
[352.662294] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[352.723220] [086/156] (666s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[352.773849] Starting subtest: wait-all-for-submit-delayed-submit
[352.877305] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.107s)
[352.950478] [087/156] (666s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[353.047112] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[353.050951] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[353.156659] [088/156] (666s left) vgem_basic (second-client)
[353.196714] Starting subtest: second-client
[353.217055] Subtest second-client: SUCCESS (0.022s)
[353.274322] [089/156] (666s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[353.370445] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[353.374366] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[353.468804] [090/156] (666s left) gem_eio (in-flight-suspend)
[353.687011] Starting subtest: in-flight-suspend
[397.392939] Subtest in-flight-suspend: SUCCESS (13.921s)
[397.550945] [091/156] (622s left) gem_mmap_gtt (basic-copy)
[397.618601] Subtest basic-copy: SKIP (0.000s)
[397.682767] [092/156] (622s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[397.772878] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[397.777952] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[397.846082] [093/156] (622s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[397.903005] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[397.907589] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[398.087782] [094/156] (621s left) perf (polling-small-buf)
[398.179564] Starting subtest: polling-small-buf
[398.267586] Subtest polling-small-buf: SUCCESS (0.087s)
[398.315357] [095/156] (621s left) kms_pm_lpsp (screens-disabled)
[399.415686] Starting subtest: screens-disabled
[399.420082] Subtest screens-disabled: SKIP (0.000s)
[399.490413] [096/156] (620s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[399.594264] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[399.598287] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[399.709447] [097/156] (620s left) kms_pm_rpm (modeset-non-lpsp)
[401.631425] Starting subtest: modeset-non-lpsp
[402.796077] Subtest modeset-non-lpsp: SKIP (1.172s)
[403.204330] [098/156] (616s left) kms_hdr (static-toggle-suspend)
[403.295011] Starting subtest: static-toggle-suspend
[403.297360] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[403.301649] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[403.312185] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[403.316133] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[403.320296] Subtest static-toggle-suspend: SKIP (0.003s)
[403.381569] [099/156] (616s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[403.483690] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[403.488080] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[403.592854] [100/156] (616s left) gem_flink_race (flink_close)
[403.633216] Starting subtest: flink_close
[408.748810] Subtest flink_close: SUCCESS (5.129s)
[408.838533] [101/156] (611s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt)
[408.952548] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt
[408.956663] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[409.068938] [102/156] (611s left) syncobj_wait (single-wait-signaled)
[409.136800] Starting subtest: single-wait-signaled
[409.139084] Subtest single-wait-signaled: SUCCESS (0.000s)
[409.251697] [103/156] (611s left) gem_ctx_param (invalid-param-set)
[409.295783] Starting subtest: invalid-param-set
[409.298061] Subtest invalid-param-set: SUCCESS (0.000s)
[409.360616] [104/156] (611s left) gem_ctx_isolation (preservation)
[409.420660] Starting subtest: preservation
[409.422600] Starting dynamic subtest: rcs0
[409.555591] Dynamic subtest rcs0: SUCCESS (0.134s)
[409.569645] Starting dynamic subtest: bcs0
[409.711557] Dynamic subtest bcs0: SUCCESS (0.155s)
[409.722938] Starting dynamic subtest: vcs0
[409.848105] Dynamic subtest vcs0: SUCCESS (0.136s)
[409.859300] Starting dynamic subtest: vcs1
[411.542615] Dynamic subtest vcs1: SUCCESS (1.697s)
[411.553614] Starting dynamic subtest: vecs0
[413.593874] Dynamic subtest vecs0: SUCCESS (2.053s)
[413.605047] Starting dynamic subtest: ccs0
[415.610614] Dynamic subtest ccs0: SUCCESS (2.016s)
[415.614230] Subtest preservation: SUCCESS (6.197s)
[415.844057] [105/156] (604s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[415.955841] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[415.960001] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[416.044132] [106/156] (604s left) gem_create (create-massive)
[416.108597] Starting subtest: create-massive
[416.110795] Subtest create-massive: SUCCESS (0.000s)
[416.294249] [107/156] (604s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[416.402283] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[416.406782] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[416.525395] [108/156] (604s left) kms_plane (plane-panning-top-left)
[416.620171] Starting subtest: plane-panning-top-left
[416.622095] Starting dynamic subtest: pipe-A
[418.282977] Dynamic subtest pipe-A: SUCCESS (1.665s)
[418.294777] Starting dynamic subtest: pipe-B
[420.668127] Dynamic subtest pipe-B: SUCCESS (2.386s)
[420.670647] Subtest plane-panning-top-left: SUCCESS (4.054s)
[421.542463] [109/156] (599s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[421.637239] Starting subtest: fbc-pr-sprite-mmap-cpu
[421.641737] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[421.711591] [110/156] (599s left) gem_exec_balancer (full)
[421.776620] Starting subtest: full
[426.297279] Subtest full: SUCCESS (4.523s)
[426.624991] [111/156] (594s left) i915_pm_rpm (system-suspend)
[428.559502] Starting subtest: system-suspend
[446.927656] Subtest system-suspend: SUCCESS (2.982s)
[447.302349] [112/156] (573s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[447.415138] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[447.419137] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[447.519539] [113/156] (573s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[447.612571] Starting subtest: fbcpsr-rgb101010-draw-render
[452.326476] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.861s)
[452.471257] [114/156] (568s left) core_auth (getclient-simple)
[452.505643] Starting subtest: getclient-simple
[452.517171] Subtest getclient-simple: SUCCESS (0.013s)
[452.629402] [115/156] (568s left) kms_draw_crc (draw-method-render)
[452.735074] Starting subtest: draw-method-render
[452.737360] Starting dynamic subtest: xrgb8888-untiled
[452.963749] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[452.974420] Starting dynamic subtest: rgb565-untiled
[453.170162] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[453.181399] Starting dynamic subtest: xrgb2101010-untiled
[453.387797] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[453.398804] Starting dynamic subtest: xbgr16161616f-untiled
[453.627610] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[453.643576] Starting dynamic subtest: xrgb8888-xtiled
[453.758793] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[453.771244] Starting dynamic subtest: rgb565-xtiled
[453.878790] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[453.890560] Starting dynamic subtest: xrgb2101010-xtiled
[453.998912] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[454.011190] Starting dynamic subtest: xbgr16161616f-xtiled
[454.130229] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[454.141168] Starting dynamic subtest: xrgb8888-4tiled
[454.261382] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[454.271895] Starting dynamic subtest: rgb565-4tiled
[454.370258] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[454.380865] Starting dynamic subtest: xrgb2101010-4tiled
[454.490638] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[454.501177] Starting dynamic subtest: xbgr16161616f-4tiled
[454.621737] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[454.623683] Subtest draw-method-render: SUCCESS (1.923s)
[454.760397] [116/156] (566s left) kms_pm_backlight (basic-brightness)
[454.850310] Starting subtest: basic-brightness
[454.903028] Starting dynamic subtest: eDP-1
[455.412084] Dynamic subtest eDP-1: SUCCESS (0.515s)
[455.414115] Subtest basic-brightness: SUCCESS (0.567s)
[456.208434] [117/156] (564s left) prime_self_import (basic-with_fd_dup)
[456.241363] Starting subtest: basic-with_fd_dup
[456.260215] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[456.362180] [118/156] (564s left) kms_color_pipeline (plane-ctm3x4)
[456.463483] Starting subtest: plane-ctm3x4
[456.640915] Starting dynamic subtest: pipe-A-plane-0
[456.761533] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[456.772787] Starting dynamic subtest: pipe-A-plane-1
[456.916973] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[456.929823] Starting dynamic subtest: pipe-A-plane-2
[457.025999] Dynamic subtest pipe-A-plane-2: SUCCESS (0.111s)
[458.304780] Starting dynamic subtest: pipe-B-plane-0
[458.439407] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[458.450833] Starting dynamic subtest: pipe-B-plane-1
[458.548127] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[458.559525] Starting dynamic subtest: pipe-B-plane-2
[458.703308] Dynamic subtest pipe-B-plane-2: SUCCESS (0.154s)
[459.849022] Starting dynamic subtest: pipe-C-plane-0
[459.950598] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[459.963896] Starting dynamic subtest: pipe-C-plane-1
[460.082881] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[460.096748] Starting dynamic subtest: pipe-C-plane-2
[460.192344] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[461.418265] Starting dynamic subtest: pipe-D-plane-0
[461.519185] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[461.532071] Starting dynamic subtest: pipe-D-plane-1
[461.629343] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[461.640370] Starting dynamic subtest: pipe-D-plane-2
[461.763356] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[462.047303] Subtest plane-ctm3x4: SUCCESS (5.633s)
[462.872066] [119/156] (558s left) gem_mmap_wc (bad-object)
[462.932731] Subtest bad-object: SKIP (0.000s)
[462.996837] [120/156] (558s left) kms_invalid_mode (int-max-clock)
[463.095382] Starting subtest: int-max-clock
[463.097588] Starting dynamic subtest: pipe-A-eDP-1
[463.391999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[463.402864] Starting dynamic subtest: pipe-B-eDP-1
[463.405217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[463.415512] Starting dynamic subtest: pipe-C-eDP-1
[463.417398] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[463.427652] Starting dynamic subtest: pipe-D-eDP-1
[463.429597] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[463.431547] Subtest int-max-clock: SUCCESS (0.306s)
[464.250330] [121/156] (556s left) gem_flink_race (flink_name)
[464.283800] Starting subtest: flink_name
[469.659624] Subtest flink_name: SUCCESS (5.389s)
[469.786305] [122/156] (551s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[469.887461] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[469.891827] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[470.002217] [123/156] (551s left) syncobj_timeline (multi-wait-available-signaled)
[470.055596] Starting subtest: multi-wait-available-signaled
[470.057998] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[470.145907] [124/156] (551s left) kms_psr (fbc-psr2-dpms)
[470.246549] Starting subtest: fbc-psr2-dpms
[470.248816] Starting dynamic subtest: eDP-1
[470.253156] Dynamic subtest eDP-1: SKIP (0.000s)
[470.256998] Subtest fbc-psr2-dpms: SKIP (0.001s)
[470.321653] [125/156] (551s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[470.418363] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[470.422440] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[470.499870] [126/156] (550s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[470.586321] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[470.588547] Starting dynamic subtest: pipe-A-eDP-1
[470.644647] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[470.654957] Starting dynamic subtest: pipe-B-eDP-1
[470.701224] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[470.712280] Starting dynamic subtest: pipe-C-eDP-1
[470.758603] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[470.769666] Starting dynamic subtest: pipe-D-eDP-1
[470.816340] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[470.819980] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.011s)
[472.816519] [127/156] (548s left) i915_drm_fdinfo (busy-idle)
[472.852018] Starting subtest: busy-idle
[472.854469] Starting dynamic subtest: rcs0
[472.876693] Dynamic subtest rcs0: SKIP (0.022s)
[472.889168] Starting dynamic subtest: bcs0
[472.897722] Dynamic subtest bcs0: SKIP (0.021s)
[472.908172] Starting dynamic subtest: vcs0
[472.912199] Dynamic subtest vcs0: SKIP (0.000s)
[472.922395] Starting dynamic subtest: vcs1
[472.927067] Dynamic subtest vcs1: SKIP (0.000s)
[472.939713] Starting dynamic subtest: vecs0
[472.943825] Dynamic subtest vecs0: SKIP (0.000s)
[472.953797] Starting dynamic subtest: ccs0
[472.957830] Dynamic subtest ccs0: SKIP (0.000s)
[472.962001] Subtest busy-idle: SKIP (0.048s)
[473.000317] [128/156] (548s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[473.092735] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[473.097118] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[473.205070] [129/156] (548s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[473.263044] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[473.368798] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[473.448779] [130/156] (548s left) vgem_basic (bad-flag)
[473.488031] Starting subtest: bad-flag
[473.490146] Subtest bad-flag: SUCCESS (0.000s)
[473.542902] [131/156] (548s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[473.627876] Starting subtest: plane-primary-toggle-with-vblank-wait
[473.630238] Starting dynamic subtest: pipe-A-eDP-1
[473.800527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[474.108067] Starting dynamic subtest: pipe-B-eDP-1
[474.987309] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.892s)
[475.291824] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.666s)
[476.113014] [132/156] (545s left) prime_vgem (basic-read)
[476.180337] Starting subtest: basic-read
[476.192721] Subtest basic-read: SKIP (0.010s)
[476.303651] [133/156] (545s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[476.410727] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[476.414916] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[476.516057] [134/156] (545s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[476.616493] Starting subtest: yf-tiled-64bpp-rotate-90
[476.621028] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[476.719968] [135/156] (545s left) gen9_exec_parse (shadow-peek)
[476.784296] Subtest shadow-peek: SKIP (0.000s)
[476.851190] [136/156] (544s left) fbdev (unaligned-write)
[476.902250] Starting subtest: unaligned-write
[477.003997] Subtest unaligned-write: SUCCESS (0.100s)
[477.066888] [137/156] (544s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[477.165008] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[477.169207] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.261621] [138/156] (544s left) gem_exec_schedule (promotion)
[477.329457] Starting subtest: promotion
[477.331290] Starting dynamic subtest: rcs0
[477.435007] Dynamic subtest rcs0: SUCCESS (0.110s)
[477.449082] Starting dynamic subtest: vcs0
[477.534398] Dynamic subtest vcs0: SUCCESS (0.098s)
[477.549375] Starting dynamic subtest: vcs1
[477.627066] Dynamic subtest vcs1: SUCCESS (0.090s)
[477.639417] Starting dynamic subtest: vecs0
[477.704330] Dynamic subtest vecs0: SUCCESS (0.077s)
[477.716041] Starting dynamic subtest: ccs0
[477.795052] Dynamic subtest ccs0: SUCCESS (0.090s)
[477.797534] Subtest promotion: SUCCESS (0.471s)
[479.033076] [139/156] (542s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[479.128716] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[479.132969] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[479.238822] [140/156] (542s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[479.327065] Starting subtest: psr-rgb101010-draw-mmap-gtt
[479.331143] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[479.442102] [141/156] (542s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[479.545238] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[479.549807] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[479.639894] [142/156] (542s left) i915_pm_rps (waitboost)
[479.697699] Starting subtest: waitboost
[486.046362] Subtest waitboost: SUCCESS (6.344s)
[486.137405] [143/156] (535s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[486.196043] Starting subtest: invalid-smem-bo-on-discrete
[486.200983] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[486.337446] [144/156] (535s left) kms_properties (get_properties-sanity-non-atomic)
[486.443124] Starting subtest: get_properties-sanity-non-atomic
[486.445356] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[486.516877] [145/156] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[486.609677] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[486.614083] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[486.710556] [146/156] (535s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[486.807372] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[487.897121] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[488.024857] [147/156] (534s left) gem_exec_fence (submit67)
[488.204015] Starting subtest: submit67
[488.208757] Subtest submit67: SKIP (0.000s)
[490.022003] [148/156] (532s left) gem_exec_schedule (implicit-write-read)
[490.094355] Starting subtest: implicit-write-read
[490.096272] Starting dynamic subtest: rcs0
[490.198607] Dynamic subtest rcs0: SUCCESS (0.113s)
[490.212870] Starting dynamic subtest: vcs0
[490.283384] Dynamic subtest vcs0: SUCCESS (0.084s)
[490.296847] Starting dynamic subtest: vcs1
[490.361544] Dynamic subtest vcs1: SUCCESS (0.077s)
[490.379682] Starting dynamic subtest: vecs0
[490.441395] Dynamic subtest vecs0: SUCCESS (0.080s)
[490.457039] Starting dynamic subtest: ccs0
[490.532681] Dynamic subtest ccs0: SUCCESS (0.091s)
[490.535220] Subtest implicit-write-read: SUCCESS (0.449s)
[492.043625] [149/156] (530s left) kms_vblank (wait-forked-busy-hang)
[492.134068] Starting subtest: wait-forked-busy-hang
[492.135964] Starting dynamic subtest: pipe-A-eDP-1
[518.740854] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.607s)
[518.757521] Starting dynamic subtest: pipe-D-eDP-1
[543.698515] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.961s)
[543.701008] Subtest wait-forked-busy-hang: SUCCESS (51.572s)
[544.510845] [150/156] (477s left) gem_exec_async (forked-writes)
[544.573362] Starting subtest: forked-writes
[544.575798] Starting dynamic subtest: rcs0
[544.607034] Dynamic subtest rcs0: SUCCESS (0.033s)
[544.621047] Starting dynamic subtest: bcs0
[544.633390] Dynamic subtest bcs0: SUCCESS (0.025s)
[544.648269] Starting dynamic subtest: vcs0
[544.657213] Dynamic subtest vcs0: SUCCESS (0.023s)
[544.670491] Starting dynamic subtest: vcs1
[544.681494] Dynamic subtest vcs1: SUCCESS (0.023s)
[544.694913] Starting dynamic subtest: vecs0
[544.705022] Dynamic subtest vecs0: SUCCESS (0.022s)
[544.717306] Starting dynamic subtest: ccs0
[544.729704] Dynamic subtest ccs0: SUCCESS (0.023s)
[544.731911] Subtest forked-writes: SUCCESS (0.156s)
[544.965992] [151/156] (477s left) gem_ctx_persistence (hostile)
[545.017347] Starting subtest: hostile
[555.169236] Subtest hostile: SUCCESS (10.143s)
[555.286817] [152/156] (467s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[555.381765] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[555.384208] Starting dynamic subtest: pipe-A-eDP-1
[555.456401] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[555.467711] Starting dynamic subtest: pipe-B-eDP-1
[556.560622] Dynamic subtest pipe-B-eDP-1: SKIP (1.101s)
[556.565354] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.181s)
[557.828910] [153/156] (464s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[557.926662] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[557.931210] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[559.030279] [154/156] (463s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[559.125991] Starting subtest: 4-tiled-64bpp-rotate-270
[559.147530] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.021s)
[559.279173] [155/156] (463s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[559.378362] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[559.382604] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[559.453760] [156/156] (463s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[559.556139] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[566.269445] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.718s)
[566.420747] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_atomic
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_madvise
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: gem_exec_flush
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: prime_busy
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_fenced_exec_thrash
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cdclk
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_debugfs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_big
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_params
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_plane_lowres
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: gem_busy
results: parsing output: 67/ for test: kms_hdmi_inject
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_mmap
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: i915_pciid
results: parsing output: 76/ for test: testdisplay
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_pm_lpsp
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: kms_hdr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_flink_race
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_ctx_param
results: parsing output: 103/ for test: gem_ctx_isolation
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: i915_pm_rpm
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: core_auth
results: parsing output: 114/ for test: kms_draw_crc
results: parsing output: 115/ for test: kms_pm_backlight
results: parsing output: 116/ for test: prime_self_import
results: parsing output: 117/ for test: kms_color_pipeline
results: parsing output: 118/ for test: gem_mmap_wc
results: parsing output: 119/ for test: kms_invalid_mode
results: parsing output: 120/ for test: gem_flink_race
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: kms_atomic_transition
results: parsing output: 131/ for test: prime_vgem
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: gen9_exec_parse
results: parsing output: 135/ for test: fbdev
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_exec_schedule
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: i915_pm_rps
results: parsing output: 142/ for test: kms_addfb_basic
results: parsing output: 143/ for test: kms_properties
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: gem_exec_fence
results: parsing output: 147/ for test: gem_exec_schedule
results: parsing output: 148/ for test: kms_vblank
results: parsing output: 149/ for test: gem_exec_async
results: parsing output: 150/ for test: gem_ctx_persistence
results: parsing output: 151/ for test: kms_psr2_sf
results: parsing output: 152/ for test: kms_ccs
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_flip_scaled_crc
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.